builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1483083255.86 results: success (0) buildid: 20161229194837 builduid: 61f2dd70eaab4ee2969318a10f7b9ba6 revision: ddfb48730883391cb38347d34917deaa978b9bc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:15.859767) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:15.860256) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:15.860542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:15.874883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:15.875219) ========= 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=5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-29 23:34:16-- 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% 42.7M=0s 2016-12-29 23:34:16 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:16.007629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:16.007949) ========= 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=5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016373 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:16.058015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:16.058396) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ddfb48730883391cb38347d34917deaa978b9bc1 --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 ddfb48730883391cb38347d34917deaa978b9bc1 --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=5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-29 23:34:16,337 truncating revision to first 12 chars 2016-12-29 23:34:16,337 Setting DEBUG logging. 2016-12-29 23:34:16,337 attempt 1/10 2016-12-29 23:34:16,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ddfb48730883?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 23:34:16,848 unpacking tar archive at: mozilla-inbound-ddfb48730883/testing/mozharness/ program finished with exit code 0 elapsedTime=0.970442 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:17.042394) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:17.042720) ========= script_repo_revision: ddfb48730883391cb38347d34917deaa978b9bc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:17.043146) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:17.043426) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 23:34:17.053337) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-29 23:34:17.053673) ========= /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=5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:34:17 INFO - MultiFileLogger online at 20161229 23:34:17 in /builds/slave/test 23:34:17 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 23:34:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:34:17 INFO - {'append_to_log': False, 23:34:17 INFO - 'base_work_dir': '/builds/slave/test', 23:34:17 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 23:34:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:34:17 INFO - 'branch': 'Mozilla-Inbound', 23:34:17 INFO - 'buildbot_json_path': 'buildprops.json', 23:34:17 INFO - 'config_files': ('talos/linux_config.py',), 23:34:17 INFO - 'default_actions': ('clobber', 23:34:17 INFO - 'read-buildbot-config', 23:34:17 INFO - 'download-and-extract', 23:34:17 INFO - 'populate-webroot', 23:34:17 INFO - 'create-virtualenv', 23:34:17 INFO - 'install', 23:34:17 INFO - 'run-tests'), 23:34:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:34:17 INFO - 'download_minidump_stackwalk': True, 23:34:17 INFO - 'download_symbols': 'ondemand', 23:34:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:34:17 INFO - 'tooltool.py': '/tools/tooltool.py', 23:34:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:34:17 INFO - '/tools/misc-python/virtualenv.py')}, 23:34:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:34:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:34:17 INFO - 'installer_path': 'installer.exe', 23:34:17 INFO - 'log_level': 'info', 23:34:17 INFO - 'log_name': 'talos', 23:34:17 INFO - 'log_to_console': True, 23:34:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:34:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:34:17 INFO - 'opt_config_files': (), 23:34:17 INFO - 'pip_index': False, 23:34:17 INFO - 'sps_profile': False, 23:34:17 INFO - 'sps_profile_interval': 0, 23:34:17 INFO - 'suite': 'dromaeojs-e10s', 23:34:17 INFO - 'system_bits': '32', 23:34:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:34:17 INFO - 'title': 'talos-linux64-ix-039', 23:34:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:34:17 INFO - 'use_talos_json': True, 23:34:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:34:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:34:17 INFO - 'work_dir': 'build'} 23:34:17 INFO - [mozharness: 2016-12-30 07:34:17.425606Z] Running clobber step. 23:34:17 INFO - Running pre-action listener: _resource_record_pre_action 23:34:17 INFO - Running main action method: clobber 23:34:17 INFO - rmtree: /builds/slave/test/build 23:34:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:34:18 INFO - Running post-action listener: _resource_record_post_action 23:34:18 INFO - [mozharness: 2016-12-30 07:34:18.613561Z] Finished clobber step (success) 23:34:18 INFO - [mozharness: 2016-12-30 07:34:18.613660Z] Running read-buildbot-config step. 23:34:18 INFO - Running pre-action listener: _resource_record_pre_action 23:34:18 INFO - Running main action method: read_buildbot_config 23:34:18 INFO - Using buildbot properties: 23:34:18 INFO - { 23:34:18 INFO - "project": "", 23:34:18 INFO - "product": "firefox", 23:34:18 INFO - "script_repo_revision": "production", 23:34:18 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 23:34:18 INFO - "repository": "", 23:34:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 23:34:18 INFO - "buildid": "20161229194837", 23:34:18 INFO - "stage_platform": "linux64-pgo", 23:34:18 INFO - "basedir": "/builds/slave/test", 23:34:18 INFO - "buildnumber": 2175, 23:34:18 INFO - "platform": "ubuntu64_hw", 23:34:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:34:18 INFO - "slavebuilddir": "test", 23:34:18 INFO - "branch": "mozilla-inbound", 23:34:18 INFO - "revision": "ddfb48730883391cb38347d34917deaa978b9bc1", 23:34:18 INFO - "slavename": "talos-linux64-ix-039", 23:34:18 INFO - "builduid": "61f2dd70eaab4ee2969318a10f7b9ba6", 23:34:18 INFO - "repo_path": "integration/mozilla-inbound" 23:34:18 INFO - } 23:34:18 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 23:34:18 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 23:34:18 INFO - Running post-action listener: _resource_record_post_action 23:34:18 INFO - [mozharness: 2016-12-30 07:34:18.616007Z] Finished read-buildbot-config step (success) 23:34:18 INFO - [mozharness: 2016-12-30 07:34:18.616097Z] Running download-and-extract step. 23:34:18 INFO - Running pre-action listener: _resource_record_pre_action 23:34:18 INFO - Running main action method: download_and_extract 23:34:18 INFO - mkdir: /builds/slave/test/build/tests 23:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:18 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 23:34:18 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/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 23:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/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 23:34:18 INFO - Downloaded 1361 bytes. 23:34:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 23:34:18 INFO - Using the following test package requirements: 23:34:18 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 23:34:18 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:34:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:34:18 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:34:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:34:18 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:34:18 INFO - u'jsshell-linux-x86_64.zip'], 23:34:18 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:34:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:34:18 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 23:34:18 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:34:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:34:18 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:34:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:34:18 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:34:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:34:18 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:34:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:34:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:34:18 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/1483062618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 23:34:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:34:18 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:34:18 INFO - Expected file size: 21836713 23:34:18 INFO - Obtained file size: 21836713 23:34:22 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 23:34:22 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/1483062618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 23:34:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:34:22 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:34:23 INFO - Expected file size: 21836713 23:34:23 INFO - Obtained file size: 21836713 23:34:27 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/1483062618/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 23:34:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:34:27 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:34:27 INFO - Expected file size: 14409776 23:34:27 INFO - Obtained file size: 14409776 23:34: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')]} 23:34:28 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 23:34:28 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/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 23:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/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 23:34:28 INFO - Downloaded 61254111 bytes. 23:34:28 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 23:34:28 INFO - mkdir: /builds/slave/test/properties 23:34:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:34:28 INFO - Writing to file /builds/slave/test/properties/build_url 23:34:28 INFO - Contents: 23:34:28 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 23:34:29 INFO - Running post-action listener: _resource_record_post_action 23:34:29 INFO - Running post-action listener: set_extra_try_arguments 23:34:29 INFO - [mozharness: 2016-12-30 07:34:29.119444Z] Finished download-and-extract step (success) 23:34:29 INFO - [mozharness: 2016-12-30 07:34:29.119671Z] Running populate-webroot step. 23:34:29 INFO - Running pre-action listener: _resource_record_pre_action 23:34:29 INFO - Running main action method: populate_webroot 23:34:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:34:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:34:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:34:29 INFO - '--tppagecycles', 23:34:29 INFO - '7'], 23:34:29 INFO - 'tests': ['tsvgm']}}, 23:34:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:34:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:34:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:34:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:34:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 23:34:29 INFO - 'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:34:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:34:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:34:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 23:34:29 INFO - 'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['damp', 'tps']}, 23:34:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:34:29 INFO - 'tests': ['damp', 'tps']}, 23:34:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['dromaeo_dom']}, 23:34:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:34:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['basic_compositor_video']}, 23:34:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:34:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['a11yr', 23:34:29 INFO - 'ts_paint', 23:34:29 INFO - 'tpaint', 23:34:29 INFO - 'sessionrestore', 23:34:29 INFO - 'sessionrestore_no_auto_restore', 23:34:29 INFO - 'tabpaint']}, 23:34:29 INFO - 'other-e10s': {'tests': ['a11yr', 23:34:29 INFO - 'ts_paint', 23:34:29 INFO - 'tpaint', 23:34:29 INFO - 'sessionrestore', 23:34:29 INFO - 'sessionrestore_no_auto_restore', 23:34:29 INFO - 'tabpaint']}, 23:34:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:34:29 INFO - 'ts_paint', 23:34:29 INFO - 'tpaint', 23:34:29 INFO - 'sessionrestore', 23:34:29 INFO - 'sessionrestore_no_auto_restore', 23:34:29 INFO - 'tabpaint']}, 23:34:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:34:29 INFO - 'ts_paint', 23:34:29 INFO - 'tpaint', 23:34:29 INFO - 'sessionrestore', 23:34:29 INFO - 'sessionrestore_no_auto_restore', 23:34:29 INFO - 'tabpaint']}, 23:34:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['a11yr', 23:34:29 INFO - 'ts_paint', 23:34:29 INFO - 'tpaint', 23:34:29 INFO - 'sessionrestore', 23:34:29 INFO - 'sessionrestore_no_auto_restore', 23:34:29 INFO - 'tabpaint']}, 23:34:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['a11yr', 23:34:29 INFO - 'ts_paint', 23:34:29 INFO - 'tpaint', 23:34:29 INFO - 'sessionrestore', 23:34:29 INFO - 'sessionrestore_no_auto_restore', 23:34:29 INFO - 'tabpaint']}, 23:34:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['tsvgx', 23:34:29 INFO - 'tsvgr_opacity', 23:34:29 INFO - 'tart', 23:34:29 INFO - 'tscrollx', 23:34:29 INFO - 'cart', 23:34:29 INFO - 'tsvg_static']}, 23:34:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:34:29 INFO - 'tsvgr_opacity', 23:34:29 INFO - 'tart', 23:34:29 INFO - 'tscrollx', 23:34:29 INFO - 'cart', 23:34:29 INFO - 'tsvg_static']}, 23:34:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 23:34:29 INFO - 'talos_options': ['--disable-e10s'], 23:34:29 INFO - 'tests': ['tp5o']}, 23:34:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:34:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 23:34:29 INFO - 'talos_options': ['--disable-e10s', 23:34:29 INFO - '--xperf_path', 23:34:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:34:29 INFO - 'tests': ['tp5n']}, 23:34:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:34:29 INFO - 'talos_options': ['--xperf_path', 23:34:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:34:29 INFO - 'tests': ['tp5n']}}, 23:34:29 INFO - 'talos.zip': {'path': '', 23:34:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:34:29 INFO - Running post-action listener: _resource_record_post_action 23:34:29 INFO - [mozharness: 2016-12-30 07:34:29.140665Z] Finished populate-webroot step (success) 23:34:29 INFO - [mozharness: 2016-12-30 07:34:29.140754Z] Running create-virtualenv step. 23:34:29 INFO - Running pre-action listener: _resource_record_pre_action 23:34:29 INFO - Running main action method: create_virtualenv 23:34:29 INFO - Creating virtualenv /builds/slave/test/build/venv 23:34:29 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 23:34:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:34:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:34:29 INFO - Using real prefix '/usr' 23:34:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:34:29 INFO - Installing distribute.............................................................................................................................................................................................done. 23:34:31 INFO - Installing pip.................done. 23:34:31 INFO - Return code: 0 23:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:34:31 INFO - Reading from file tmpfile_stdout 23:34:31 INFO - Output received: 23:34:31 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) 23:34:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c55480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', '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 23:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:34:31 INFO - Using env: {'DISPLAY': ':0', 23:34:31 INFO - 'HOME': '/home/cltbld', 23:34:31 INFO - 'LANG': 'en_US.UTF-8', 23:34:31 INFO - 'LANGUAGE': 'en_US:en', 23:34:31 INFO - 'LOGNAME': 'cltbld', 23:34:31 INFO - 'MAIL': '/var/mail/cltbld', 23:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:31 INFO - 'MOZ_NO_REMOTE': '1', 23:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:31 INFO - 'NO_EM_RESTART': '1', 23:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:31 INFO - 'PWD': '/builds/slave/test', 23:34:31 INFO - 'SHELL': '/bin/bash', 23:34:31 INFO - 'SHLVL': '1', 23:34:31 INFO - 'TERM': 'linux', 23:34:31 INFO - 'TMOUT': '86400', 23:34:31 INFO - 'USER': 'cltbld', 23:34:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:31 INFO - '_': '/tools/buildbot/bin/python'} 23:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:34:32 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 23:34:32 INFO - Cleaning up... 23:34:32 INFO - Return code: 0 23:34:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:34:32 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')]} 23:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:32 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')]} 23:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:32 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c55480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', '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 23:34:32 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 23:34:32 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 23:34:32 INFO - Using env: {'DISPLAY': ':0', 23:34:32 INFO - 'HOME': '/home/cltbld', 23:34:32 INFO - 'LANG': 'en_US.UTF-8', 23:34:32 INFO - 'LANGUAGE': 'en_US:en', 23:34:32 INFO - 'LOGNAME': 'cltbld', 23:34:32 INFO - 'MAIL': '/var/mail/cltbld', 23:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:32 INFO - 'MOZ_NO_REMOTE': '1', 23:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:32 INFO - 'NO_EM_RESTART': '1', 23:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:32 INFO - 'PWD': '/builds/slave/test', 23:34:32 INFO - 'SHELL': '/bin/bash', 23:34:32 INFO - 'SHLVL': '1', 23:34:32 INFO - 'TERM': 'linux', 23:34:32 INFO - 'TMOUT': '86400', 23:34:32 INFO - 'USER': 'cltbld', 23:34:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:32 INFO - '_': '/tools/buildbot/bin/python'} 23:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:34:32 INFO - Downloading/unpacking psutil>=3.1.1 23:34:32 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 23:34:32 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 23:34:32 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 23:34:32 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 23:34:32 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 23:34:32 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 23:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:34:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:34:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:34:34 INFO - Installing collected packages: psutil 23:34:34 INFO - Running setup.py install for psutil 23:34:34 INFO - building 'psutil._psutil_linux' extension 23:34:34 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 23:34:34 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 23:34:34 INFO - building 'psutil._psutil_posix' extension 23:34:34 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 23:34:34 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 23:34:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:34:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:34:34 INFO - Successfully installed psutil 23:34:34 INFO - Cleaning up... 23:34:35 INFO - Return code: 0 23:34:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:34:35 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')]} 23:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:35 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')]} 23:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:35 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c55480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', '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 23:34:35 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 23:34:35 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 23:34:35 INFO - Using env: {'DISPLAY': ':0', 23:34:35 INFO - 'HOME': '/home/cltbld', 23:34:35 INFO - 'LANG': 'en_US.UTF-8', 23:34:35 INFO - 'LANGUAGE': 'en_US:en', 23:34:35 INFO - 'LOGNAME': 'cltbld', 23:34:35 INFO - 'MAIL': '/var/mail/cltbld', 23:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:35 INFO - 'MOZ_NO_REMOTE': '1', 23:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:35 INFO - 'NO_EM_RESTART': '1', 23:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:35 INFO - 'PWD': '/builds/slave/test', 23:34:35 INFO - 'SHELL': '/bin/bash', 23:34:35 INFO - 'SHLVL': '1', 23:34:35 INFO - 'TERM': 'linux', 23:34:35 INFO - 'TMOUT': '86400', 23:34:35 INFO - 'USER': 'cltbld', 23:34:35 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:35 INFO - '_': '/tools/buildbot/bin/python'} 23:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:34:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:34:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:34:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:34:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:34:37 INFO - Installing collected packages: mozsystemmonitor 23:34:37 INFO - Running setup.py install for mozsystemmonitor 23:34:37 INFO - Successfully installed mozsystemmonitor 23:34:37 INFO - Cleaning up... 23:34:37 INFO - Return code: 0 23:34:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:37 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c55480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', '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 23:34:37 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 23:34:37 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 23:34:37 INFO - Using env: {'DISPLAY': ':0', 23:34:37 INFO - 'HOME': '/home/cltbld', 23:34:37 INFO - 'LANG': 'en_US.UTF-8', 23:34:37 INFO - 'LANGUAGE': 'en_US:en', 23:34:37 INFO - 'LOGNAME': 'cltbld', 23:34:37 INFO - 'MAIL': '/var/mail/cltbld', 23:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:37 INFO - 'MOZ_NO_REMOTE': '1', 23:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:37 INFO - 'NO_EM_RESTART': '1', 23:34:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:37 INFO - 'PWD': '/builds/slave/test', 23:34:37 INFO - 'SHELL': '/bin/bash', 23:34:37 INFO - 'SHLVL': '1', 23:34:37 INFO - 'TERM': 'linux', 23:34:37 INFO - 'TMOUT': '86400', 23:34:37 INFO - 'USER': 'cltbld', 23:34:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:37 INFO - '_': '/tools/buildbot/bin/python'} 23:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:34:37 INFO - Downloading/unpacking jsonschema==2.5.1 23:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:34:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:34:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:34:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:34:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:34:39 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 23:34:39 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 23:34:39 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 23:34:39 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 23:34:39 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 23:34:39 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 23:34:39 INFO - Downloading functools32-3.2.3-2.tar.gz 23:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:34:39 INFO - warning: no files found matching '*.txt' 23:34:39 INFO - no previously-included directories found matching 'build' 23:34:39 INFO - no previously-included directories found matching 'dist' 23:34:39 INFO - no previously-included directories found matching '.git*' 23:34:39 INFO - Installing collected packages: jsonschema, functools32 23:34:39 INFO - Running setup.py install for functools32 23:34:40 INFO - warning: no files found matching '*.txt' 23:34:40 INFO - no previously-included directories found matching 'build' 23:34:40 INFO - no previously-included directories found matching 'dist' 23:34:40 INFO - no previously-included directories found matching '.git*' 23:34:40 INFO - Successfully installed jsonschema functools32 23:34:40 INFO - Cleaning up... 23:34:40 INFO - Return code: 0 23:34:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:40 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c55480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', '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 23:34:40 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 23:34:40 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 23:34:40 INFO - Using env: {'DISPLAY': ':0', 23:34:40 INFO - 'HOME': '/home/cltbld', 23:34:40 INFO - 'LANG': 'en_US.UTF-8', 23:34:40 INFO - 'LANGUAGE': 'en_US:en', 23:34:40 INFO - 'LOGNAME': 'cltbld', 23:34:40 INFO - 'MAIL': '/var/mail/cltbld', 23:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:40 INFO - 'MOZ_NO_REMOTE': '1', 23:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:40 INFO - 'NO_EM_RESTART': '1', 23:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:40 INFO - 'PWD': '/builds/slave/test', 23:34:40 INFO - 'SHELL': '/bin/bash', 23:34:40 INFO - 'SHLVL': '1', 23:34:40 INFO - 'TERM': 'linux', 23:34:40 INFO - 'TMOUT': '86400', 23:34:40 INFO - 'USER': 'cltbld', 23:34:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:40 INFO - '_': '/tools/buildbot/bin/python'} 23:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:34:40 INFO - Cleaning up... 23:34:40 INFO - Return code: 0 23:34:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:40 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c55480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', '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 23:34:40 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 23:34:40 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 23:34:40 INFO - Using env: {'DISPLAY': ':0', 23:34:40 INFO - 'HOME': '/home/cltbld', 23:34:40 INFO - 'LANG': 'en_US.UTF-8', 23:34:40 INFO - 'LANGUAGE': 'en_US:en', 23:34:40 INFO - 'LOGNAME': 'cltbld', 23:34:40 INFO - 'MAIL': '/var/mail/cltbld', 23:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:40 INFO - 'MOZ_NO_REMOTE': '1', 23:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:40 INFO - 'NO_EM_RESTART': '1', 23:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:40 INFO - 'PWD': '/builds/slave/test', 23:34:40 INFO - 'SHELL': '/bin/bash', 23:34:40 INFO - 'SHLVL': '1', 23:34:40 INFO - 'TERM': 'linux', 23:34:40 INFO - 'TMOUT': '86400', 23:34:40 INFO - 'USER': 'cltbld', 23:34:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:40 INFO - '_': '/tools/buildbot/bin/python'} 23:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:34:40 INFO - Downloading/unpacking blobuploader==1.2.4 23:34:40 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 23:34:40 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 23:34:40 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 23:34:40 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 23:34:40 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 23:34:40 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 23:34:42 INFO - Downloading blobuploader-1.2.4.tar.gz 23:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:34:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:34:42 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 23:34:42 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 23:34:42 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 23:34:42 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 23:34:42 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 23:34:42 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 23:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:34:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:34:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:34:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:34:43 INFO - Downloading docopt-0.6.1.tar.gz 23:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:34:43 INFO - Installing collected packages: blobuploader, requests, docopt 23:34:43 INFO - Running setup.py install for blobuploader 23:34:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:34:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:34:43 INFO - Running setup.py install for requests 23:34:43 INFO - Running setup.py install for docopt 23:34:43 INFO - Successfully installed blobuploader requests docopt 23:34:43 INFO - Cleaning up... 23:34:44 INFO - Return code: 0 23:34:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:44 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c55480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', '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 23:34:44 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 23:34:44 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 23:34:44 INFO - Using env: {'DISPLAY': ':0', 23:34:44 INFO - 'HOME': '/home/cltbld', 23:34:44 INFO - 'LANG': 'en_US.UTF-8', 23:34:44 INFO - 'LANGUAGE': 'en_US:en', 23:34:44 INFO - 'LOGNAME': 'cltbld', 23:34:44 INFO - 'MAIL': '/var/mail/cltbld', 23:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:44 INFO - 'MOZ_NO_REMOTE': '1', 23:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:44 INFO - 'NO_EM_RESTART': '1', 23:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:44 INFO - 'PWD': '/builds/slave/test', 23:34:44 INFO - 'SHELL': '/bin/bash', 23:34:44 INFO - 'SHLVL': '1', 23:34:44 INFO - 'TERM': 'linux', 23:34:44 INFO - 'TMOUT': '86400', 23:34:44 INFO - 'USER': 'cltbld', 23:34:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:44 INFO - '_': '/tools/buildbot/bin/python'} 23:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:34:44 INFO - Running setup.py (path:/tmp/pip-h_Z79V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:34:44 INFO - Running setup.py (path:/tmp/pip-BJ60HO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:34:44 INFO - Running setup.py (path:/tmp/pip-W9a52K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:34:44 INFO - Running setup.py (path:/tmp/pip-w04p7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:34:44 INFO - Running setup.py (path:/tmp/pip-ndwa_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:34:44 INFO - Running setup.py (path:/tmp/pip-Y0g1HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:34:44 INFO - Running setup.py (path:/tmp/pip-j3SBeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:34:44 INFO - Running setup.py (path:/tmp/pip-mY4heO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:34:44 INFO - Running setup.py (path:/tmp/pip-UOgojz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:34:44 INFO - Running setup.py (path:/tmp/pip-Hl2Vvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:34:44 INFO - Running setup.py (path:/tmp/pip-mIeDVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:34:45 INFO - Running setup.py (path:/tmp/pip-STYLbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:34:45 INFO - Running setup.py (path:/tmp/pip-fCbCQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:34:45 INFO - Running setup.py (path:/tmp/pip-ogpphk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:34:45 INFO - Running setup.py (path:/tmp/pip-ydJRPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:34:45 INFO - Running setup.py (path:/tmp/pip-w02Emq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:34:45 INFO - Running setup.py (path:/tmp/pip-rp4Beh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:34:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:34:45 INFO - Running setup.py install for manifestparser 23:34:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:34:45 INFO - Running setup.py install for mozcrash 23:34:45 INFO - Running setup.py install for mozdebug 23:34:45 INFO - Running setup.py install for mozdevice 23:34:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:34:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:34:45 INFO - Running setup.py install for mozfile 23:34:45 INFO - Running setup.py install for mozhttpd 23:34:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Running setup.py install for mozinfo 23:34:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Running setup.py install for mozInstall 23:34:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Running setup.py install for mozleak 23:34:46 INFO - Running setup.py install for mozlog 23:34:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Running setup.py install for moznetwork 23:34:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Running setup.py install for mozprocess 23:34:46 INFO - Running setup.py install for mozprofile 23:34:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Running setup.py install for mozrunner 23:34:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:34:46 INFO - Running setup.py install for mozscreenshot 23:34:47 INFO - Running setup.py install for moztest 23:34:47 INFO - Running setup.py install for mozversion 23:34:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:34:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:34:47 INFO - Cleaning up... 23:34:47 INFO - Return code: 0 23:34:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:34: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')]} 23:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34: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')]} 23:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:47 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c55480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', '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 23:34:47 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 23:34:47 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 23:34:47 INFO - Using env: {'DISPLAY': ':0', 23:34:47 INFO - 'HOME': '/home/cltbld', 23:34:47 INFO - 'LANG': 'en_US.UTF-8', 23:34:47 INFO - 'LANGUAGE': 'en_US:en', 23:34:47 INFO - 'LOGNAME': 'cltbld', 23:34:47 INFO - 'MAIL': '/var/mail/cltbld', 23:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:47 INFO - 'MOZ_NO_REMOTE': '1', 23:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:47 INFO - 'NO_EM_RESTART': '1', 23:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:47 INFO - 'PWD': '/builds/slave/test', 23:34:47 INFO - 'SHELL': '/bin/bash', 23:34:47 INFO - 'SHLVL': '1', 23:34:47 INFO - 'TERM': 'linux', 23:34:47 INFO - 'TMOUT': '86400', 23:34:47 INFO - 'USER': 'cltbld', 23:34:47 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:47 INFO - '_': '/tools/buildbot/bin/python'} 23:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:34:47 INFO - Running setup.py (path:/tmp/pip-nP7NxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:34:47 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)) 23:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:34:47 INFO - Running setup.py (path:/tmp/pip-LhYigB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:34:47 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)) 23:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:34:47 INFO - Running setup.py (path:/tmp/pip-qlX6EZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:34:47 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)) 23:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:34:47 INFO - Running setup.py (path:/tmp/pip-Sg0LRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:34:47 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)) 23:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:34:47 INFO - Running setup.py (path:/tmp/pip-iGSOfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:34:47 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)) 23:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:34:47 INFO - Running setup.py (path:/tmp/pip-BjxUOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:34:47 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)) 23:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:34:47 INFO - Running setup.py (path:/tmp/pip-mwyk1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:34:47 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)) 23:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:34:47 INFO - Running setup.py (path:/tmp/pip-hIu6fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:34:48 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)) 23:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:34:48 INFO - Running setup.py (path:/tmp/pip-Wg4Ql2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:34:48 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)) 23:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:34:48 INFO - Running setup.py (path:/tmp/pip-MP5cFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:34:48 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)) 23:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:34:48 INFO - Running setup.py (path:/tmp/pip-1L33gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:34:48 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)) 23:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:34:48 INFO - Running setup.py (path:/tmp/pip-4DhJIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:34:48 INFO - Running setup.py (path:/tmp/pip-PX42IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:34:48 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)) 23:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:34:48 INFO - Running setup.py (path:/tmp/pip-54ImUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:34:48 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)) 23:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:34:48 INFO - Running setup.py (path:/tmp/pip-cDvu9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:34:48 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)) 23:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:34:48 INFO - Running setup.py (path:/tmp/pip-M_CMEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:34:48 INFO - Running setup.py (path:/tmp/pip-z0CGl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:34:48 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)) 23:34:48 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)) 23:34:48 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)) 23:34:48 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)) 23:34:48 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)) 23:34:48 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)) 23:34:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:34:48 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 23:34:48 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 23:34:48 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 23:34:48 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 23:34:48 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 23:34:48 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 23:34:50 INFO - Downloading blessings-1.6.tar.gz 23:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:34:50 INFO - Installing collected packages: blessings 23:34:50 INFO - Running setup.py install for blessings 23:34:50 INFO - Successfully installed blessings 23:34:50 INFO - Cleaning up... 23:34:50 INFO - Return code: 0 23:34:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:34:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:34:51 INFO - Reading from file tmpfile_stdout 23:34:51 INFO - Current package versions: 23:34:51 INFO - argparse == 1.2.1 23:34:51 INFO - blessings == 1.6 23:34:51 INFO - blobuploader == 1.2.4 23:34:51 INFO - docopt == 0.6.1 23:34:51 INFO - functools32 == 3.2.3-2 23:34:51 INFO - jsonschema == 2.5.1 23:34:51 INFO - manifestparser == 1.1 23:34:51 INFO - mozInstall == 1.12 23:34:51 INFO - mozcrash == 1.0 23:34:51 INFO - mozdebug == 0.1 23:34:51 INFO - mozdevice == 0.49 23:34:51 INFO - mozfile == 1.2 23:34:51 INFO - mozhttpd == 0.7 23:34:51 INFO - mozinfo == 0.9 23:34:51 INFO - mozleak == 0.1 23:34:51 INFO - mozlog == 3.4 23:34:51 INFO - moznetwork == 0.27 23:34:51 INFO - mozprocess == 0.23 23:34:51 INFO - mozprofile == 0.28 23:34:51 INFO - mozrunner == 6.13 23:34:51 INFO - mozscreenshot == 0.1 23:34:51 INFO - mozsystemmonitor == 0.3 23:34:51 INFO - moztest == 0.7 23:34:51 INFO - mozversion == 1.4 23:34:51 INFO - psutil == 3.1.1 23:34:51 INFO - requests == 1.2.3 23:34:51 INFO - wsgiref == 0.1.2 23:34:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:34: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')]} 23:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34: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')]} 23:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34:51 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c55480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', '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 23:34:51 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 23:34:51 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 23:34:51 INFO - Using env: {'DISPLAY': ':0', 23:34:51 INFO - 'HOME': '/home/cltbld', 23:34:51 INFO - 'LANG': 'en_US.UTF-8', 23:34:51 INFO - 'LANGUAGE': 'en_US:en', 23:34:51 INFO - 'LOGNAME': 'cltbld', 23:34:51 INFO - 'MAIL': '/var/mail/cltbld', 23:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:51 INFO - 'MOZ_NO_REMOTE': '1', 23:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:51 INFO - 'NO_EM_RESTART': '1', 23:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:51 INFO - 'PWD': '/builds/slave/test', 23:34:51 INFO - 'SHELL': '/bin/bash', 23:34:51 INFO - 'SHLVL': '1', 23:34:51 INFO - 'TERM': 'linux', 23:34:51 INFO - 'TMOUT': '86400', 23:34:51 INFO - 'USER': 'cltbld', 23:34:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:51 INFO - '_': '/tools/buildbot/bin/python'} 23:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:34:51 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)) 23:34:51 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)) 23:34:51 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)) 23:34:51 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)) 23:34:51 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)) 23:34:51 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)) 23:34:51 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)) 23:34:51 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)) 23:34:51 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)) 23:34:51 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)) 23:34:51 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)) 23:34:51 INFO - Cleaning up... 23:34:51 INFO - Return code: 0 23:34:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:34: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')]} 23:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34: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')]} 23:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:34: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c55480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, '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': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', '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 23:34: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', 'jsonschema'] in /builds/slave/test/build 23:34: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 jsonschema 23:34:51 INFO - Using env: {'DISPLAY': ':0', 23:34:51 INFO - 'HOME': '/home/cltbld', 23:34:51 INFO - 'LANG': 'en_US.UTF-8', 23:34:51 INFO - 'LANGUAGE': 'en_US:en', 23:34:51 INFO - 'LOGNAME': 'cltbld', 23:34:51 INFO - 'MAIL': '/var/mail/cltbld', 23:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:51 INFO - 'MOZ_NO_REMOTE': '1', 23:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:51 INFO - 'NO_EM_RESTART': '1', 23:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:51 INFO - 'PWD': '/builds/slave/test', 23:34:51 INFO - 'SHELL': '/bin/bash', 23:34:51 INFO - 'SHLVL': '1', 23:34:51 INFO - 'TERM': 'linux', 23:34:51 INFO - 'TMOUT': '86400', 23:34:51 INFO - 'USER': 'cltbld', 23:34:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:51 INFO - '_': '/tools/buildbot/bin/python'} 23:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:34:51 INFO - Cleaning up... 23:34:51 INFO - Return code: 0 23:34:51 INFO - Running post-action listener: _resource_record_post_action 23:34:51 INFO - Running post-action listener: _start_resource_monitoring 23:34:51 INFO - Starting resource monitoring. 23:34:51 INFO - [mozharness: 2016-12-30 07:34:51.671415Z] Finished create-virtualenv step (success) 23:34:51 INFO - [mozharness: 2016-12-30 07:34:51.671944Z] Running install step. 23:34:51 INFO - Running pre-action listener: _resource_record_pre_action 23:34:51 INFO - Running main action method: install 23:34:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:34:51 INFO - Reading from file tmpfile_stdout 23:34:51 INFO - Detecting whether we're running mozinstall >=1.0... 23:34:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:34:51 INFO - Reading from file tmpfile_stdout 23:34:51 INFO - Output received: 23:34:51 INFO - Usage: mozinstall [options] installer 23:34:51 INFO - Options: 23:34:51 INFO - -h, --help show this help message and exit 23:34:51 INFO - -d DEST, --destination=DEST 23:34:51 INFO - Directory to install application into. [default: 23:34:51 INFO - "/builds/slave/test"] 23:34:51 INFO - --app=APP Application being installed. [default: firefox] 23:34:51 INFO - mkdir: /builds/slave/test/build/application 23:34:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:35:09 INFO - Reading from file tmpfile_stdout 23:35:09 INFO - Output received: 23:35:09 INFO - /builds/slave/test/build/application/firefox/firefox 23:35:09 INFO - Running post-action listener: _resource_record_post_action 23:35:09 INFO - [mozharness: 2016-12-30 07:35:09.279230Z] Finished install step (success) 23:35:09 INFO - [mozharness: 2016-12-30 07:35:09.279508Z] Running run-tests step. 23:35:09 INFO - Running pre-action listener: _resource_record_pre_action 23:35:09 INFO - Running main action method: run_tests 23:35:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:35:09 INFO - Python 2.7.3 23:35:09 INFO - Return code: 0 23:35:09 INFO - grabbing minidump binary from tooltool 23:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:35:09 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 0x1c52820>, '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 0x1c53520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c539b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:35:09 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 23:35:09 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 23:35:09 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 23:35:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:35:09 INFO - Return code: 0 23:35:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:35:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:35:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:35:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:35:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:35:09 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/1483062618/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 23:35:09 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/1483062618/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 23:35:09 INFO - Using env: {'DISPLAY': ':0', 23:35:09 INFO - 'HOME': '/home/cltbld', 23:35:09 INFO - 'LANG': 'en_US.UTF-8', 23:35:09 INFO - 'LANGUAGE': 'en_US:en', 23:35:09 INFO - 'LOGNAME': 'cltbld', 23:35:09 INFO - 'MAIL': '/var/mail/cltbld', 23:35:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:35:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:35:09 INFO - 'MOZ_NO_REMOTE': '1', 23:35:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:35:09 INFO - 'NO_EM_RESTART': '1', 23:35:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:35:09 INFO - 'PWD': '/builds/slave/test', 23:35:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:35:09 INFO - 'SHELL': '/bin/bash', 23:35:09 INFO - 'SHLVL': '1', 23:35:09 INFO - 'TERM': 'linux', 23:35:09 INFO - 'TMOUT': '86400', 23:35:09 INFO - 'USER': 'cltbld', 23:35:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641', 23:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:35:09 INFO - '_': '/tools/buildbot/bin/python'} 23:35:09 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/1483062618/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 23:35:09 INFO - mozversion application_buildid: 20161229175018 23:35:09 INFO - mozversion application_changeset: ddfb48730883391cb38347d34917deaa978b9bc1 23:35:09 INFO - mozversion application_display_name: Nightly 23:35:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:35:09 INFO - mozversion application_name: Firefox 23:35:09 INFO - mozversion application_remotingname: firefox 23:35:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:35:09 INFO - mozversion application_vendor: Mozilla 23:35:09 INFO - mozversion application_version: 53.0a1 23:35:09 INFO - mozversion platform_buildid: 20161229175018 23:35:09 INFO - mozversion platform_changeset: ddfb48730883391cb38347d34917deaa978b9bc1 23:35:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:35:09 INFO - mozversion platform_version: 53.0a1 23:35:09 INFO - using testdate: 1483083309 23:35:09 INFO - actual date: 1483083309 23:35:09 INFO - starting webserver on 'localhost:39389' 23:35:09 INFO - SUITE-START | Running 2 tests 23:35:09 INFO - TEST-START | dromaeo_css 23:35:09 INFO - operating with platform_type : linux_ 23:35:09 INFO - Initialising browser for dromaeo_css test... 23:35:09 INFO - TEST-INFO | started process 3741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZntOsA/profile http://localhost:39389/getInfo.html) 23:35:10 INFO - PROCESS | 3741 | 1483083310011 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 23:35:13 INFO - PROCESS | 3741 | __metrics Screen width/height:1600/1200 23:35:13 INFO - PROCESS | 3741 | colorDepth:24 23:35:13 INFO - PROCESS | 3741 | Browser inner width/height: 1024/697 23:35:13 INFO - PROCESS | 3741 | __metrics 23:35:14 ERROR - PROCESS | 3741 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 23:35:15 INFO - TEST-INFO | 3741: exit 0 23:35:15 INFO - Browser initialized. 23:35:15 INFO - Running cycle 1/1 for dromaeo_css test... 23:35:15 INFO - TEST-INFO | started process 3867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZntOsA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:35:27 INFO - PROCESS | 3867 | RSS: Main: 154349568 23:35:27 INFO - PROCESS | 3867 | 23:38:27 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:39389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39389/tests/dromaeo/cssquery-ext.html) 23:38:28 INFO - PROCESS | 3867 | RSS: Main: 164818944 23:38:28 INFO - PROCESS | 3867 | 23:40:15 INFO - PROCESS | 3867 | ************************* 23:40:15 INFO - PROCESS | 3867 | A coding exception was thrown and uncaught in a Task. 23:40:15 INFO - PROCESS | 3867 | 23:40:15 INFO - PROCESS | 3867 | Full message: ReferenceError: fetch is not defined 23:40:15 INFO - PROCESS | 3867 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 23:40:15 INFO - PROCESS | 3867 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 23:40:15 INFO - PROCESS | 3867 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 23:40:15 INFO - PROCESS | 3867 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 23:40:15 INFO - PROCESS | 3867 | TaskImpl@resource://gre/modules/Task.jsm:277:3 23:40:15 INFO - PROCESS | 3867 | asyncFunction@resource://gre/modules/Task.jsm:252:14 23:40:15 INFO - PROCESS | 3867 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 23:40:15 INFO - PROCESS | 3867 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 23:40:15 INFO - PROCESS | 3867 | TaskImpl@resource://gre/modules/Task.jsm:277:3 23:40:15 INFO - PROCESS | 3867 | asyncFunction@resource://gre/modules/Task.jsm:252:14 23:40:15 INFO - PROCESS | 3867 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 23:40:15 INFO - PROCESS | 3867 | 23:40:15 INFO - PROCESS | 3867 | ************************* 23:41:30 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:39389/tests/dromaeo/cssquery-ext.html (next: http://localhost:39389/tests/dromaeo/cssquery-jquery.html) 23:41:31 INFO - PROCESS | 3867 | RSS: Main: 161447936 23:41:31 INFO - PROCESS | 3867 | 23:44:33 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:39389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39389/tests/dromaeo/cssquery-mootools.html) 23:44:34 INFO - PROCESS | 3867 | RSS: Main: 166805504 23:44:34 INFO - PROCESS | 3867 | 23:47:35 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:39389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39389/tests/dromaeo/cssquery-prototype.html) 23:47:36 INFO - PROCESS | 3867 | RSS: Main: 162033664 23:47:36 INFO - PROCESS | 3867 | 23:50:39 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:39389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39389/tests/dromaeo/cssquery-yui.html) 23:50:39 INFO - PROCESS | 3867 | RSS: Main: 164220928 23:50:39 INFO - PROCESS | 3867 | 23:53:42 INFO - PROCESS | 3867 | Cycle 1(1): loaded http://localhost:39389/tests/dromaeo/cssquery-yui.html (next: http://localhost:39389/tests/dromaeo/cssquery-dojo.html) 23:53:42 INFO - PROCESS | 3867 | RSS: Main: 165736448 23:53:42 INFO - PROCESS | 3867 | 23:53:42 INFO - PROCESS | 3867 | __start_tp_report 23:53:42 INFO - PROCESS | 3867 | _x_x_mozilla_page_load 23:53:42 INFO - PROCESS | 3867 | _x_x_mozilla_page_load_details 23:53:42 INFO - PROCESS | 3867 | |i|pagename|runs| 23:53:42 INFO - PROCESS | 3867 | |0;dojo.html;3119.750419966402;3130.5304204369354;3137.607799025122;3158.0683698308994;3158.5104308832138;5320.787168513255;5375.6505827121255;5389.5688344932405;5403;5435.592330575213;5334.066538355792;5386.380566234884;5392.137258038714;5394.460553944604;5446.618736688433;4909.116359055369;4909.852704418864;4955.08330958772;5033.899322013557;5056.797728090872;4812.23004319309;4969.676970996874;4985.501449855004;4993.251012348141;5080.415752188509;4873.415190177201;4889.926651100236;4979.004199160165;5010.849674509771;5032.2703208035;4891.266310053485;4893.559579637814;4938.38270216223;4946.9010619787405;5008.84973450797;4890.193118135503;4907.8773030674165;4914.311996320518;4915.262710593403;4926.310316555685;5309.973450132725;5419.187121931703;5442.156465747776;5466.426025267329;5473.917891231635;5735.254416925814;5764.452377024176;5856.560757943172;5859.501942334907;5992.370801065869;5965.433283838029;5967.970160149215;5970.791022314198;5983.58114931955;5985.670788106652;5531.806386776484;5544.833654990357;5546.833594992117;5548.500634942794;5548.55611551075;5842.065269556851;5889.734961926723;5931.822045338647;5938.673372964442;5978.641281523122;5661.405552416937;5743.770249189985;5757.913631295534;5782.566307526952;5804.303483581913;5814.970925145347;5820.679862607512;5835.066389377679;5869.5010924071075;5875.441833025856;5741.282339707536;5742.167385729046;5772.191893134965;5779.075347944393;5795.1017592273265;5798.5071268941765;5813.7383817728305;5820.417958204146;5828.59199856006;5886.23478947734;4353.281708518059;4354.912901742011;4381.583749543788;4389.561043895585;4414.381986521889;3825.540935087807;3847.2690188864585;3852.171783066654;3895.2014836958356;3920.5687374388795;5585.804496842591;5591.07747221712;5602.075657516546;5632.155176723442;5653.321601407857;5866.413358664099;5880.764769409261;5913.994620914455;5950.047992321294;5953.583249172603;5432.348118225759;5454.481824226692;5532.944670553324;5643.40744221859;5649.152627105967;4771.165046116985;4827.08285425768;4844.249141383091;4858.271259311061;4883.267509873547;6104.908426373608;6111.327753947062;6119.449249567471;6132.172156758869;6139.570230083851;5725.742341594721;5774.133879918046;5877.089051197071;5883.264591926009;5891.823245302648;6028.3971602839365;6071.605345652519;6079.665618391031;6090.390960904051;6096.481799046954;5738.081906894877;5765.106408506688;5781.190633311256;5782.277215348082;5793.131030345482;5803.535717142534;5844.590878638454;5860.882782344244;5869.94130058711;5872.0898260769645;5694.572907031907;5726.255586773693;5729.770809167587;5749.683767392834;5783.94216057834;5676.744546495335;5716.657000579979;5744.138379243147;5751.74117164737;5752.539796816161;5521.889562208653;5595.804146854841;5608.383077861514;5667.631603945895;5704.771809127588;5745.195672605755;5752.712364381848;5752.7698892043845;5754.712264386848;5755.107958266475;5631.521320687623;5637.379888212211;5664.745086471036;5665.12190610456;5673.375928647928 23:53:42 INFO - PROCESS | 3867 | |1;ext.html;543.3696911582565;549.7828357798667;550.3698265486018;591.1871177131442;610.2311088029082;41100;42598.14803703928;42625.57374426258;46040.76979615106;46191.30713039307;44812.3278150828;44870.77564612172;44939.77530112353;44941.55058449414;45095.77452112743;8924.152205540495;9088.727338179866;9097.22673572747;9105.817883642323;10037.096661300482;10045.899541004606;10047.196224302075;10066.496675166212;10086.445245511493;10152.086312231897;10143;10224.437655928921;10249.128824049927;10252.28234023615;10264;10093.192544596452;10118.696439106838;10153.644622438253;10172.593096276214;10236.283460157754;10013.39919604826;10062.64780732678;10068;10077.899221007843;10108.140808031252;37548.43677344815;37838.243235135145;37893;38041.42937855935;38113;4024.6919751080723;4093.2018256440006;4119.443875076856;4136.627703506669;4141.79291035447;28453;28512.28719282014;28997.275068123254;29082.563761543595;29157.854210729023;4229.281022226229;4283.550227226158;4459.531749166355;4536.637069034469;4573.108243892442;350444;351059;353321;355640;355823;50142;50665.49334506682;50705.74647126815;50711.746441267554;50790;53351;53647.19529207065;54062.729686352104;54272.643183920714;54422.27888605554;13547.864521354857;13699.45202191921;13770;13902.652433689238;13922.164670119826;10247.538860751283;10334.328268662513;11141.721456963478;11218.046466050313;11329.943350283196;16513.752293715603;16532.338706451847;16585.751213731804;16645.50063498097;16704.916475417544;6695.765648202289;6771.966140169367;6848.623325717033;6862.348076932683;6885.483588730865;889.822035592884;893.2764460786783;895.3016647015338;899.6941040046415;923.0861447167256;28115.43769124606;28654.14037578876;29048.273793155342;29225;29714.554281685792;1045.4041196518065;1057.8836328003913;1079.1636481726568;1080.438172150493;1174.4890972427022;15080.773788393182;15588.220588970506;15735.68528629421;15742.606434839221;16070.75893861593;473550;474252;475123;475429.32562755037;475497;56711.43288567061;56719.43280567224;56814.147787783215;57378;57508.71245643745;1301.4533895763802;1324.5893772930615;1326.2838067443665;1332.6401871494643;1370.2600595678223;28013.579796302663;29115.272118197216;29480.557791632713;29910.953116640812;30022.84988575043;48880.51119488759;49429.25856112089;49438.25842612292;49538.50461495339;49539;389911;392123;393199;393532;394319;23191.88404057969;23526.294211173692;23957.28128156158;24823;27307.86346068257;38461.615383845805;38539.807300963315;38582.22835543217;38690;39483.802580988064;32945;32946;33097.50353744648;33116.62491550387;33199.66800332062;31607.525887111253;31871.521927171576;32401;32999;33204.335913282084;31897.840510798225;32307.35385292328;32458;32682.50976235406;34928.82535587306;27901.302467438476;28616.42767144604;32893.67106328906;33198.83400583078;33212.50181247235;25320.493590128463;25987.870060649577;26094.73905260923;26172.73827261703;26303.4739305209 23:53:42 INFO - PROCESS | 3867 | |2;jquery.html;403.97778122203266;405.7869618450315;407.60462351519027;408.97137200395963;422.1809689202946;15028.248587570632;17610.999999999985;18187.363442279522;18877.716834247498;19051.618967620638;17148.657026859488;17348.306067757276;17376.218070186842;18259.543511412223;18574.72137917929;5597.916031259534;5608;5698.6580805151825;5737.512311453532;5800.245968024151;5598.412166722496;5640.492355687988;5679.7160141992945;5680.261565996435;5686.687232202227;5954.9404505955035;5964.3737407572235;5969.13447550105;5979.342272350038;6012.5791194616395;5826.475617194473;5955.808838232328;5962.642241465504;5976.282846058479;5983.640981541122;5802.796902108406;5825.155352473867;5846.766129354821;5849.385814489502;5861.794837180721;14471.78292325616;14584.927075364662;21889.67165492519;22149.557008859734;22217.666734998988;2570.9871450642813;2611.3732704150866;2658.7607115359515;2717.3885875677815;2723.9182824515296;10286;10296.588136474533;10515.842262365994;10675.83986240207;10788.406637634927;1961.2547232051872;1994.524052201375;1995.6308083004546;2002.7096071069614;2017.1527958257568;68079;74074.25925740728;74129;74462.62768686176;76868;10739.301945373525;10999.450027498593;11034.558617655204;11124.165687573464;11231.326120432801;12191.573294934635;12825.23048617086;15401.691966160839;15422.614434639;15493;7631.427642926803;7656.9234307657325;7666.65500052499;7690.653920573588;7893.644785984645;7503.399728021745;7604.8479030419085;7628.8855667165035;7814.921850781419;7867.685292588347;4103.220388126306;4113.691473139526;4170.687198460128;4182.142660754538;4238.046439551138;2000.3498862869626;2039;2072.9067191976096;2105.315772373954;2112.556363163753;877.1973644115691;892.3040028777564;897.264243320471;903.9502827344559;936.4100616611491;16834.831651683573;17039.14804259807;17321.56696082583;17594.38419655306;17655.38206162778;916.9679061232824;921.6405601815297;923.1091996223677;923.4044041593269;925.7731855695398;9546.618135274512;9723.270754693427;9936.254780891462;10070.496475176213;10079.092881640687;372035;377204;381383;382153;385938;74861;76558;77346.6132669333;77653;78674;972.6449845806371;981.7447463659357;1002.3885429887763;1006.0442579549457;1008.0776089877826;15162.545123646309;15187.848121519086;15308.387664493295;15624.375024998873;15776.447824326093;26888.462230754885;35042.29915401729;36536;37078;37677;47899.52100478951;48140.7592962047;48511;48544.271835923195;50949.7452512735;8404.36967227448;8434.409591328547;8498.660053597787;8603.52680602573;8904.777380565538;10821.296615719953;12650.557230496888;12690.302033388252;12913.289769062792;12966.740665186831;10705.411202383631;10794.406307653155;11145.665630031112;11298.548058077586;11364.659060228207;6260.68696565179;7135.785926422215;9922.305438619516;10134.645287414905;10491.580336786443;11096.944515277371;11273.492692829006;11293.887061129284;11317;11704.473298701749;8188.877166842622;8196.83606327882;8369.874451883348;8479.19447652472;8522.190391912758;9993.800123997626;11037;11197.384143872165;11304.773904521699;11570.537178513101 23:53:42 INFO - PROCESS | 3867 | |3;mootools.html;1382.0532934939567;1389.624801303648;1399.8600139985997;1400.6428360768002;1404.0662959132173;8026.919730802698;8310.501369917809;8478.152184781518;8562.871556926644;8581.313494920414;8530;8669.089745576703;8673.219410253076;8709.608067636957;8746.693865714702;2290.8854557272152;2321.3964369263945;2331.6152834782242;2333.3233362324904;2339.2046704120594;2074.3984244569133;2134.925277615284;2142.9892850535803;2277.9202727904526;2334.031376978552;2186.726659167604;2201.3506015725397;2208.4258092895884;2209.3703294561055;2212.1593794358123;2204.2175027865037;2224.110355857662;2229.342344008521;2233.2965115988413;2233.3300009997015;2235.4634887627017;2242.932712018642;2268.092762894839;2278.9544209115725;2291.209532711212;8560.571971401467;8584.356173287028;8674.653013879437;8683.652653893836;8712.956435217846;5028.220625803006;5199.766010529535;5227.163653815409;5242.318498595197;5261.079311120577;3006.9248268793235;3206.599175103112;3260.2012506935953;3334.7165490933057;3390.6100798408006;1418.2837666978214;1422.3172877018985;1455.4687539048277;1468.625500497377;1481.2149560732828;11762.705932351673;11777.528898844035;11843.940780296129;11858.16992810495;11877.940610296979;4140.751554906655;4205.8527951522165;4334.869953901388;4343.391925130484;4361.9127617447475;9184.311176661777;9194;9215.44707317563;9230.630774768933;9244.306676999251;5123.538881500683;5155.407128180233;5163.845084647466;5167.638265321467;5168.431472538018;4716.882077948078;4742.857714268577;4772.308015337757;4792.400949881265;4808.182608956486;3488.7440521412273;3519.489673997256;3608.675219230282;3608.675219230282;3713.440355050885;1081.0972837680624;1150.0799360511558;1163.778882012415;1185.034197129337;1189.120051162134;907.1880666803174;927.4574373991156;931.1712575807537;935.4667839331515;953.9618415263451;5393.867287869512;5411.842934483198;5447.863803404867;5503.504684578327;5544.362398324163;861.9310455163571;871.0897112517434;877.9341549383822;889.6574818694849;900.1538553759445;3612.8735494257576;3627.9637203628154;3637.799921004317;3666.5233519642275;3695.0577602711137;9784.119429251401;9898.950505247427;10085.546150423248;10405.9479702601;10407.375557466576;10387.532561034772;10409.895901041044;10421.478926053667;10428.739281518023;10444.582216711246;7743.264389882952;7995.880061799077;8062.637181326854;8070.798230044178;8071.4349995500925;5401.216823560483;5410.78356865721;5652.236948012131;5690.118031705092;5690.772369105355;8989.640414383613;9098.727038188865;9106;9171.082891710776;9191.816163676824;9057.18485336323;9141.862872056792;9177.678781242625;9284;9300.348975571645;7251.709931602677;7359.227281135403;7372.631368431665;7388.926110738824;7400.296971787671;7855.882161767692;7954.761357159295;8059.43583949118;8066.354691624773;8151.918480815116;7194.964025179841;7325.304096110861;7339.77980660581;7339.77980660581;7521.135069467081;6952.582845029315;7022.12223472066;7076.433885289268;7093.184283807428;7106.253843346374;6008.489278411209;6077.939220607737;6154.415330543591;6232.844178895564;6340.778072767615;4699.647526435463;4728.858134255978;4776.522347765195;4794.083642307505;4865.343178670834;4727.101850648503;4776.928346074881;4803.375561177164;4815.446223684321;4834.299026641188 23:53:42 INFO - PROCESS | 3867 | |4;prototype.html;386.5670449097011;386.93035253654347;387.20622723416994;390.9921801563967;399.2693371130829;5212;5295.947040529593;5302.2311764794085;5342;5359.222912677665;5208.453112423198;5328.973355133228;5334.51989320961;5351.7324133793345;5373.862126162852;4174.686898482611;4265.125649241913;4273.999999999992;4296.462942132233;4301.462317210348;4302.526722060571;4305.461817272841;4310.849120280791;4318.179545886287;4318.632916202127;4286.892827679318;4297.871063868089;4331.220380331539;4331.935020974688;4338.370936214247;4185.22573323936;4212.30496968003;4225.218334608107;4338.891527711801;4348.565143485658;3795.1460921292764;3815.5802861685193;3822.541295044585;3823.63520102311;3831.214601006787;5210.374755029383;5229.50319719626;5250.212468129773;5258.13240815265;5276.947230527722;4801.5438533339275;4940.184869496528;4968.056069346812;4976.751162441863;5002.924956125661;5645.887082258332;5679.318481782171;5691.430856914317;5718.542516598662;5720.914186287209;4248.723832950848;4267.719684094759;4271.231178387889;4280.657547396201;4298.74207547545;5760.395158508338;5832.62087964281;5843.9707801461145;5946.345901950782;5966.2840459144745;4369.2572262714775;4388.144311859157;4393.494748104009;4421.668374871833;4421.9437961347485;4459.44256967879;4483.865484035484;4491.595756381941;4500.482444518922;4525.886852828706;4804.639652026112;4907.3620429343955;4977.502249775066;5023.598112151019;5053.5957123430035;5678.829635110953;5681;5681.545476361964;5702.344230413472;5713.657180569179;1491.269278053746;1494.4844028810044;1504.653929596177;1512.5613572064199;1527.3585094260438;1011.5852500474917;1080.6379862745912;1088.8149014667526;1103.9558417663204;1112.8593191978125;5188.714620695822;5274.391310650289;5293.655912365684;5303.602229832778;5309.097453432925;5560.833175004756;5599.2003998001;5640.858978525488;5649.68926709035;5672.419049332544;5113.974430127825;5114.820981265638;5361.973190134025;5527.309086364205;5541.790716726265;3013.9752484155056;3036.5748795168693;3054.862531186102;3058.342456371891;3061.9081427557207;5683.8294851153705;5889.911651325234;5963.73163207648;5983.132445795335;5987.520998320124;5686;5703.486686198262;5734.598578099493;5757.65454072757;5766.394528574523;5831.416858314219;5880.558958078076;5892.440218179266;5909.438603332676;5917.260342457107;5513.3108361454815;5543.611947163821;5579.860503487283;5799.4780469757925;5871.1486834407915;5763.682997435181;5764.221830052889;5790.449907258803;5813.709314534171;5829.854253643693;5960.8807823844145;6074.66589337573;6117.571769976059;6128.63228206309;6187.80332981785;4135.77253251074;4157.667386609003;4161.708680392343;4177.4778152730905;4179.916401671889;5692.743826527899;5810.4189581041555;5914.303560274829;5914.34942156371;5929.9110513341475;5681.568376666207;5687.146927960839;5687.488126068673;5692.231548741032;5697.287839020122;5665.263515743092;5692.402297758841;5719.7426115824055;5733.627314224562;5756.510696590837;5473.0969390050195;5679.233303503974;5680.886382272414;5711.200431939615;5716.5998380113;5722.885542289047;5732.885342293047;5762.6830524319885;5770.769169233184;5782.681952492653;5325.467453254643;5629.718514074362;5647.915281270702;5669.234653321913;5689.662929211549 23:53:42 INFO - PROCESS | 3867 | |5;yui.html;750.740994356947;752.947293689442;787.3071696906725;825.7605294464605;867.3321542412344;14319.212443315613;15633.921830390846;15672.686546269068;15677.137757423367;15753.684926301466;14739.263036848142;14970.026948248356;14991;15020.699586008273;15544.68910621787;795.1730200591393;796.9758859865075;819.3527113580265;822.1778221778221;827.6317038917684;808.3533173461237;817.513579420244;818.0674031603946;819.6557445872747;824.5382585751998;852.2713080316333;855.8630619100945;856.6659002988839;860.6643409070467;861.1259571534897;844.9493030418195;854.3080105114846;854.363499193099;857.8927634045745;860.4493124400389;624.96875156242;625.3496363781661;625.9092431597438;626.2359920896499;626.6647343671114;15921.363145474166;16000.75998860018;16151.596210094724;16450.424235151833;16536.66926661472;15438.150901700403;15653.765193522106;15654.9217253913;15796.921015394964;15926.601834954103;11654;11764;12345.753084938251;12355.814662780065;12456.377181140997;4572.679912406133;4638.46657634373;4665.5567721066445;4717.103750287469;4717.386739723848;78241;78741;80165.19834801636;80845;80864.19135808684;11508.734039255674;11550;11692.123090768226;11799.52801887915;11823.467943942544;21532.78467215339;21859;22068;22127.557448850934;22370.44073898133;7948.602569871483;8033.156518565466;8085.231902969209;8144;8144.144864789112;4324.113556720865;4361.651067914623;4361.934570981438;4374.234508960919;4398.780060996937;3329.8335083245743;3405.7956522608724;3405.9829700851337;3413.4026545354463;3451.4995325678137;578.6383510306059;585.7159277750287;586.9002269614176;593.4836692077834;601.9307779605314;680.845966087477;689.7585844954326;691.9654017299115;695.2074634916199;699.618707804248;8799.69201077972;9198.770030749285;9252.352335336462;9625.759356016155;9673.613055477703;658.2134349452358;667.4126768443739;670.6546128743603;677.1163631460893;701.235653138082;4129.8967525812095;4318.093200427883;4337;4353.782310884443;4435.112977404532;78363.60818195986;78769;79130.6043469779;79342.6032869832;79649;68854.65572672104;69983.65008174926;71905.2809471909;72103.63948180225;72967.63516182386;62181.58001309881;65001.67499162474;66103;66407;66646.66676666682;8326.70856520019;8445.155484451505;8594.636474969433;8677.956610216908;8838.602262898057;42937.35593966155;43195.78402107969;43440.56559434365;43970;44413.55586444094;53648.73175634097;53865.73067134639;54855.451445485036;55064.44935550593;55431.722841385534;11804.586839460577;12052.51789928393;12054.276743395425;12114.15200935926;12492.188007779465;12894.29081400532;12905.548305809252;12941.627690361242;13114.344282785632;13130.540431085248;11987.580434684744;12117.27296362221;12142.575009874965;12211;12854.935725321313;12440.626781196579;12524.37378131108;12703.174293670882;12768.808467872803;12898.290594017419;11988.940055299669;11994.520219191134;12072.154949153475;12076.939615301868;12089.093318001009;10253.58985640566;10604.734881628021;10668.09321207675;10778.461076946278;11065.059469945145;9713.611455541699;10035.795704515212;10118.13995810335;10120.59517619287;10125.797484050425 23:53:42 INFO - PROCESS | 3867 | __end_tp_report 23:53:42 INFO - PROCESS | 3867 | __start_cc_report 23:53:42 INFO - PROCESS | 3867 | _x_x_mozilla_cycle_collect,315 23:53:42 INFO - PROCESS | 3867 | __end_cc_report 23:53:42 INFO - PROCESS | 3867 | __startTimestamp1483084422690__endTimestamp 23:53:42 INFO - PROCESS | 3867 | 23:53:42 INFO - PROCESS | 3867 | ------- Summary: start ------- 23:53:42 INFO - PROCESS | 3867 | Number of tests: 6 23:53:42 INFO - PROCESS | 3867 | 23:53:42 INFO - PROCESS | 3867 | [#0] dojo.html Cycles:165 Average:5419.39 Median:5665.12 stddev:644.39 (11.4%) stddev-sans-first:620.60 23:53:42 INFO - PROCESS | 3867 | Values: 3119.8 3130.5 3137.6 3158.1 3158.5 5320.8 5375.7 5389.6 5403.0 5435.6 5334.1 5386.4 5392.1 5394.5 5446.6 4909.1 4909.9 4955.1 5033.9 5056.8 4812.2 4969.7 4985.5 4993.3 5080.4 4873.4 4889.9 4979.0 5010.8 5032.3 4891.3 4893.6 4938.4 4946.9 5008.8 4890.2 4907.9 4914.3 4915.3 4926.3 5310.0 5419.2 5442.2 5466.4 5473.9 5735.3 5764.5 5856.6 5859.5 5992.4 5965.4 5968.0 5970.8 5983.6 5985.7 5531.8 5544.8 5546.8 5548.5 5548.6 5842.1 5889.7 5931.8 5938.7 5978.6 5661.4 5743.8 5757.9 5782.6 5804.3 5815.0 5820.7 5835.1 5869.5 5875.4 5741.3 5742.2 5772.2 5779.1 5795.1 5798.5 5813.7 5820.4 5828.6 5886.2 4353.3 4354.9 4381.6 4389.6 4414.4 3825.5 3847.3 3852.2 3895.2 3920.6 5585.8 5591.1 5602.1 5632.2 5653.3 5866.4 5880.8 5914.0 5950.0 5953.6 5432.3 5454.5 5532.9 5643.4 5649.2 4771.2 4827.1 4844.2 4858.3 4883.3 6104.9 6111.3 6119.4 6132.2 6139.6 5725.7 5774.1 5877.1 5883.3 5891.8 6028.4 6071.6 6079.7 6090.4 6096.5 5738.1 5765.1 5781.2 5782.3 5793.1 5803.5 5844.6 5860.9 5869.9 5872.1 5694.6 5726.3 5729.8 5749.7 5783.9 5676.7 5716.7 5744.1 5751.7 5752.5 5521.9 5595.8 5608.4 5667.6 5704.8 5745.2 5752.7 5752.8 5754.7 5755.1 5631.5 5637.4 5664.7 5665.1 5673.4 23:53:42 INFO - PROCESS | 3867 | 23:53:42 INFO - PROCESS | 3867 | [#1] ext.html Cycles:180 Average:55274.09 Median:33157.73 stddev:108548.08 (327.4%) stddev-sans-first:108774.80 23:53:42 INFO - PROCESS | 3867 | Values: 543.4 549.8 550.4 591.2 610.2 41100.0 42598.1 42625.6 46040.8 46191.3 44812.3 44870.8 44939.8 44941.6 45095.8 8924.2 9088.7 9097.2 9105.8 10037.1 10045.9 10047.2 10066.5 10086.4 10152.1 10143.0 10224.4 10249.1 10252.3 10264.0 10093.2 10118.7 10153.6 10172.6 10236.3 10013.4 10062.6 10068.0 10077.9 10108.1 37548.4 37838.2 37893.0 38041.4 38113.0 4024.7 4093.2 4119.4 4136.6 4141.8 28453.0 28512.3 28997.3 29082.6 29157.9 4229.3 4283.6 4459.5 4536.6 4573.1 350444.0 351059.0 353321.0 355640.0 355823.0 50142.0 50665.5 50705.7 50711.7 50790.0 53351.0 53647.2 54062.7 54272.6 54422.3 13547.9 13699.5 13770.0 13902.7 13922.2 10247.5 10334.3 11141.7 11218.0 11329.9 16513.8 16532.3 16585.8 16645.5 16704.9 6695.8 6772.0 6848.6 6862.3 6885.5 889.8 893.3 895.3 899.7 923.1 28115.4 28654.1 29048.3 29225.0 29714.6 1045.4 1057.9 1079.2 1080.4 1174.5 15080.8 15588.2 15735.7 15742.6 16070.8 473550.0 474252.0 475123.0 475429.3 475497.0 56711.4 56719.4 56814.1 57378.0 57508.7 1301.5 1324.6 1326.3 1332.6 1370.3 28013.6 29115.3 29480.6 29911.0 30022.8 48880.5 49429.3 49438.3 49538.5 49539.0 389911.0 392123.0 393199.0 393532.0 394319.0 23191.9 23526.3 23957.3 24823.0 27307.9 38461.6 38539.8 38582.2 38690.0 39483.8 32945.0 32946.0 33097.5 33116.6 33199.7 31607.5 31871.5 32401.0 32999.0 33204.3 31897.8 32307.4 32458.0 32682.5 34928.8 27901.3 28616.4 32893.7 33198.8 33212.5 25320.5 25987.9 26094.7 26172.7 26303.5 23:53:42 INFO - PROCESS | 3867 | 23:53:42 INFO - PROCESS | 3867 | [#2] jquery.html Cycles:180 Average:24355.69 Median:193170.99 stddev:62752.16 (32.5%) stddev-sans-first:62902.42 23:53:42 INFO - PROCESS | 3867 | Values: 404.0 405.8 407.6 409.0 422.2 15028.2 17611.0 18187.4 18877.7 19051.6 17148.7 17348.3 17376.2 18259.5 18574.7 5597.9 5608.0 5698.7 5737.5 5800.2 5598.4 5640.5 5679.7 5680.3 5686.7 5954.9 5964.4 5969.1 5979.3 6012.6 5826.5 5955.8 5962.6 5976.3 5983.6 5802.8 5825.2 5846.8 5849.4 5861.8 14471.8 14584.9 21889.7 22149.6 22217.7 2571.0 2611.4 2658.8 2717.4 2723.9 10286.0 10296.6 10515.8 10675.8 10788.4 1961.3 1994.5 1995.6 2002.7 2017.2 68079.0 74074.3 74129.0 74462.6 76868.0 10739.3 10999.5 11034.6 11124.2 11231.3 12191.6 12825.2 15401.7 15422.6 15493.0 7631.4 7656.9 7666.7 7690.7 7893.6 7503.4 7604.8 7628.9 7814.9 7867.7 4103.2 4113.7 4170.7 4182.1 4238.0 2000.3 2039.0 2072.9 2105.3 2112.6 877.2 892.3 897.3 904.0 936.4 16834.8 17039.1 17321.6 17594.4 17655.4 917.0 921.6 923.1 923.4 925.8 9546.6 9723.3 9936.3 10070.5 10079.1 372035.0 377204.0 381383.0 382153.0 385938.0 74861.0 76558.0 77346.6 77653.0 78674.0 972.6 981.7 1002.4 1006.0 1008.1 15162.5 15187.8 15308.4 15624.4 15776.4 26888.5 35042.3 36536.0 37078.0 37677.0 47899.5 48140.8 48511.0 48544.3 50949.7 8404.4 8434.4 8498.7 8603.5 8904.8 10821.3 12650.6 12690.3 12913.3 12966.7 10705.4 10794.4 11145.7 11298.5 11364.7 6260.7 7135.8 9922.3 10134.6 10491.6 11096.9 11273.5 11293.9 11317.0 11704.5 8188.9 8196.8 8369.9 8479.2 8522.2 9993.8 11037.0 11197.4 11304.8 11570.5 23:53:42 INFO - PROCESS | 3867 | 23:53:42 INFO - PROCESS | 3867 | [#3] mootools.html Cycles:180 Average:5471.49 Median:5159.63 stddev:3080.05 (59.7%) stddev-sans-first:3073.36 23:53:42 INFO - PROCESS | 3867 | Values: 1382.1 1389.6 1399.9 1400.6 1404.1 8026.9 8310.5 8478.2 8562.9 8581.3 8530.0 8669.1 8673.2 8709.6 8746.7 2290.9 2321.4 2331.6 2333.3 2339.2 2074.4 2134.9 2143.0 2277.9 2334.0 2186.7 2201.4 2208.4 2209.4 2212.2 2204.2 2224.1 2229.3 2233.3 2233.3 2235.5 2242.9 2268.1 2279.0 2291.2 8560.6 8584.4 8674.7 8683.7 8713.0 5028.2 5199.8 5227.2 5242.3 5261.1 3006.9 3206.6 3260.2 3334.7 3390.6 1418.3 1422.3 1455.5 1468.6 1481.2 11762.7 11777.5 11843.9 11858.2 11877.9 4140.8 4205.9 4334.9 4343.4 4361.9 9184.3 9194.0 9215.4 9230.6 9244.3 5123.5 5155.4 5163.8 5167.6 5168.4 4716.9 4742.9 4772.3 4792.4 4808.2 3488.7 3519.5 3608.7 3608.7 3713.4 1081.1 1150.1 1163.8 1185.0 1189.1 907.2 927.5 931.2 935.5 954.0 5393.9 5411.8 5447.9 5503.5 5544.4 861.9 871.1 877.9 889.7 900.2 3612.9 3628.0 3637.8 3666.5 3695.1 9784.1 9899.0 10085.5 10405.9 10407.4 10387.5 10409.9 10421.5 10428.7 10444.6 7743.3 7995.9 8062.6 8070.8 8071.4 5401.2 5410.8 5652.2 5690.1 5690.8 8989.6 9098.7 9106.0 9171.1 9191.8 9057.2 9141.9 9177.7 9284.0 9300.3 7251.7 7359.2 7372.6 7388.9 7400.3 7855.9 7954.8 8059.4 8066.4 8151.9 7195.0 7325.3 7339.8 7339.8 7521.1 6952.6 7022.1 7076.4 7093.2 7106.3 6008.5 6077.9 6154.4 6232.8 6340.8 4699.6 4728.9 4776.5 4794.1 4865.3 4727.1 4776.9 4803.4 4815.4 4834.3 23:53:42 INFO - PROCESS | 3867 | 23:53:42 INFO - PROCESS | 3867 | [#4] prototype.html Cycles:180 Average:4802.19 Median:5317.28 stddev:1364.63 (25.7%) stddev-sans-first:1327.60 23:53:42 INFO - PROCESS | 3867 | Values: 386.6 386.9 387.2 391.0 399.3 5212.0 5295.9 5302.2 5342.0 5359.2 5208.5 5329.0 5334.5 5351.7 5373.9 4174.7 4265.1 4274.0 4296.5 4301.5 4302.5 4305.5 4310.8 4318.2 4318.6 4286.9 4297.9 4331.2 4331.9 4338.4 4185.2 4212.3 4225.2 4338.9 4348.6 3795.1 3815.6 3822.5 3823.6 3831.2 5210.4 5229.5 5250.2 5258.1 5276.9 4801.5 4940.2 4968.1 4976.8 5002.9 5645.9 5679.3 5691.4 5718.5 5720.9 4248.7 4267.7 4271.2 4280.7 4298.7 5760.4 5832.6 5844.0 5946.3 5966.3 4369.3 4388.1 4393.5 4421.7 4421.9 4459.4 4483.9 4491.6 4500.5 4525.9 4804.6 4907.4 4977.5 5023.6 5053.6 5678.8 5681.0 5681.5 5702.3 5713.7 1491.3 1494.5 1504.7 1512.6 1527.4 1011.6 1080.6 1088.8 1104.0 1112.9 5188.7 5274.4 5293.7 5303.6 5309.1 5560.8 5599.2 5640.9 5649.7 5672.4 5114.0 5114.8 5362.0 5527.3 5541.8 3014.0 3036.6 3054.9 3058.3 3061.9 5683.8 5889.9 5963.7 5983.1 5987.5 5686.0 5703.5 5734.6 5757.7 5766.4 5831.4 5880.6 5892.4 5909.4 5917.3 5513.3 5543.6 5579.9 5799.5 5871.1 5763.7 5764.2 5790.4 5813.7 5829.9 5960.9 6074.7 6117.6 6128.6 6187.8 4135.8 4157.7 4161.7 4177.5 4179.9 5692.7 5810.4 5914.3 5914.3 5929.9 5681.6 5687.1 5687.5 5692.2 5697.3 5665.3 5692.4 5719.7 5733.6 5756.5 5473.1 5679.2 5680.9 5711.2 5716.6 5722.9 5732.9 5762.7 5770.8 5782.7 5325.5 5629.7 5647.9 5669.2 5689.7 23:53:42 INFO - PROCESS | 3867 | 23:53:42 INFO - PROCESS | 3867 | [#5] yui.html Cycles:180 Average:17604.50 Median:4652.01 stddev:22850.81 (491.2%) stddev-sans-first:22879.87 23:53:42 INFO - PROCESS | 3867 | Values: 750.7 752.9 787.3 825.8 867.3 14319.2 15633.9 15672.7 15677.1 15753.7 14739.3 14970.0 14991.0 15020.7 15544.7 795.2 797.0 819.4 822.2 827.6 808.4 817.5 818.1 819.7 824.5 852.3 855.9 856.7 860.7 861.1 844.9 854.3 854.4 857.9 860.4 625.0 625.3 625.9 626.2 626.7 15921.4 16000.8 16151.6 16450.4 16536.7 15438.2 15653.8 15654.9 15796.9 15926.6 11654.0 11764.0 12345.8 12355.8 12456.4 4572.7 4638.5 4665.6 4717.1 4717.4 78241.0 78741.0 80165.2 80845.0 80864.2 11508.7 11550.0 11692.1 11799.5 11823.5 21532.8 21859.0 22068.0 22127.6 22370.4 7948.6 8033.2 8085.2 8144.0 8144.1 4324.1 4361.7 4361.9 4374.2 4398.8 3329.8 3405.8 3406.0 3413.4 3451.5 578.6 585.7 586.9 593.5 601.9 680.8 689.8 692.0 695.2 699.6 8799.7 9198.8 9252.4 9625.8 9673.6 658.2 667.4 670.7 677.1 701.2 4129.9 4318.1 4337.0 4353.8 4435.1 78363.6 78769.0 79130.6 79342.6 79649.0 68854.7 69983.7 71905.3 72103.6 72967.6 62181.6 65001.7 66103.0 66407.0 66646.7 8326.7 8445.2 8594.6 8678.0 8838.6 42937.4 43195.8 43440.6 43970.0 44413.6 53648.7 53865.7 54855.5 55064.4 55431.7 11804.6 12052.5 12054.3 12114.2 12492.2 12894.3 12905.5 12941.6 13114.3 13130.5 11987.6 12117.3 12142.6 12211.0 12854.9 12440.6 12524.4 12703.2 12768.8 12898.3 11988.9 11994.5 12072.2 12076.9 12089.1 10253.6 10604.7 10668.1 10778.5 11065.1 9713.6 10035.8 10118.1 10120.6 10125.8 23:53:42 INFO - PROCESS | 3867 | -------- Summary: end -------- 23:53:42 INFO - PROCESS | 3867 | 23:53:43 INFO - TEST-INFO | 3867: exit 0 23:53:43 INFO - TEST-OK | dromaeo_css | took 1114009ms 23:53:43 INFO - TEST-START | kraken 23:53:43 INFO - operating with platform_type : linux_ 23:53:43 INFO - Initialising browser for kraken test... 23:53:43 INFO - TEST-INFO | started process 4216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBzta5F/profile http://localhost:39389/getInfo.html) 23:53:44 INFO - PROCESS | 4216 | 1483084424023 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 23:53:47 INFO - PROCESS | 4216 | __metrics Screen width/height:1600/1200 23:53:47 INFO - PROCESS | 4216 | colorDepth:24 23:53:47 INFO - PROCESS | 4216 | Browser inner width/height: 1024/697 23:53:47 INFO - PROCESS | 4216 | __metrics 23:53:48 ERROR - PROCESS | 4216 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 23:53:49 INFO - TEST-INFO | 4216: exit 0 23:53:49 INFO - Browser initialized. 23:53:49 INFO - Running cycle 1/1 for kraken test... 23:53:49 INFO - TEST-INFO | started process 4339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBzta5F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:54:01 INFO - PROCESS | 4339 | RSS: Main: 154103808 23:54:01 INFO - PROCESS | 4339 | 23:54:03 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39389/tests/kraken/driver.html?testName=audio-beat-detection) 23:54:04 INFO - PROCESS | 4339 | RSS: Main: 160727040 23:54:04 INFO - PROCESS | 4339 | 23:54:07 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39389/tests/kraken/driver.html?testName=audio-dft) 23:54:07 INFO - PROCESS | 4339 | RSS: Main: 159408128 23:54:07 INFO - PROCESS | 4339 | 23:54:10 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39389/tests/kraken/driver.html?testName=audio-fft) 23:54:11 INFO - PROCESS | 4339 | RSS: Main: 156565504 23:54:11 INFO - PROCESS | 4339 | 23:54:13 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39389/tests/kraken/driver.html?testName=audio-oscillator) 23:54:13 INFO - PROCESS | 4339 | RSS: Main: 157274112 23:54:13 INFO - PROCESS | 4339 | 23:54:16 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:54:16 INFO - PROCESS | 4339 | RSS: Main: 157224960 23:54:16 INFO - PROCESS | 4339 | 23:54:19 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39389/tests/kraken/driver.html?testName=imaging-darkroom) 23:54:20 INFO - PROCESS | 4339 | RSS: Main: 160501760 23:54:20 INFO - PROCESS | 4339 | 23:54:23 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39389/tests/kraken/driver.html?testName=imaging-desaturate) 23:54:24 INFO - PROCESS | 4339 | RSS: Main: 159219712 23:54:24 INFO - PROCESS | 4339 | 23:54:27 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39389/tests/kraken/driver.html?testName=json-parse-financial) 23:54:27 INFO - PROCESS | 4339 | RSS: Main: 160088064 23:54:27 INFO - PROCESS | 4339 | 23:54:29 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:54:30 INFO - PROCESS | 4339 | RSS: Main: 159703040 23:54:30 INFO - PROCESS | 4339 | 23:54:31 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39389/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:54:32 INFO - PROCESS | 4339 | RSS: Main: 160231424 23:54:32 INFO - PROCESS | 4339 | 23:54:34 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:54:35 INFO - PROCESS | 4339 | RSS: Main: 160321536 23:54:35 INFO - PROCESS | 4339 | 23:54:37 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:54:38 INFO - PROCESS | 4339 | RSS: Main: 160464896 23:54:38 INFO - PROCESS | 4339 | 23:54:41 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:54:42 INFO - PROCESS | 4339 | RSS: Main: 160456704 23:54:42 INFO - PROCESS | 4339 | 23:54:43 INFO - PROCESS | 4339 | Cycle 1(1): loaded http://localhost:39389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39389/tests/kraken/driver.html?testName=ai-astar) 23:54:44 INFO - PROCESS | 4339 | RSS: Main: 162709504 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | __start_tp_report 23:54:44 INFO - PROCESS | 4339 | _x_x_mozilla_page_load 23:54:44 INFO - PROCESS | 4339 | _x_x_mozilla_page_load_details 23:54:44 INFO - PROCESS | 4339 | |i|pagename|runs| 23:54:44 INFO - PROCESS | 4339 | |0;ai-astar;103;113;115;113;112;118;115;118;114;117 23:54:44 INFO - PROCESS | 4339 | |1;audio-beat-detection;151;120;120;168;120;123;121;121;138;125 23:54:44 INFO - PROCESS | 4339 | |2;audio-dft;164;164;164;163;162;165;171;162;163;163 23:54:44 INFO - PROCESS | 4339 | |3;audio-fft;76;77;77;101;77;76;76;76;93;76 23:54:44 INFO - PROCESS | 4339 | |4;audio-oscillator;85;84;102;85;85;85;95;83;84;100 23:54:44 INFO - PROCESS | 4339 | |5;imaging-gaussian-blur;118;118;117;117;118;118;118;118;118;118 23:54:44 INFO - PROCESS | 4339 | |6;imaging-darkroom;148;149;147;147;148;149;148;148;149;149 23:54:44 INFO - PROCESS | 4339 | |7;imaging-desaturate;96;97;96;97;96;96;96;99;97;96 23:54:44 INFO - PROCESS | 4339 | |8;json-parse-financial;56;56;57;60;62;58;57;61;58;57 23:54:44 INFO - PROCESS | 4339 | |9;json-stringify-tinderbox;67;68;68;68;68;67;67;67;67;66 23:54:44 INFO - PROCESS | 4339 | |10;stanford-crypto-aes;86;82;81;83;90;83;88;82;81;81 23:54:44 INFO - PROCESS | 4339 | |11;stanford-crypto-ccm;140;137;137;134;127;129;127;134;170;142 23:54:44 INFO - PROCESS | 4339 | |12;stanford-crypto-pbkdf2;173;172;167;164;166;175;169;172;168;172 23:54:44 INFO - PROCESS | 4339 | |13;stanford-crypto-sha256-iterative;65;65;63;70;63;64;63;66;63;70 23:54:44 INFO - PROCESS | 4339 | __end_tp_report 23:54:44 INFO - PROCESS | 4339 | __start_cc_report 23:54:44 INFO - PROCESS | 4339 | _x_x_mozilla_cycle_collect,722 23:54:44 INFO - PROCESS | 4339 | __end_cc_report 23:54:44 INFO - PROCESS | 4339 | __startTimestamp1483084484147__endTimestamp 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | ------- Summary: start ------- 23:54:44 INFO - PROCESS | 4339 | Number of tests: 14 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.00 stddev:4.34 (3.8%) stddev-sans-first:2.24 23:54:44 INFO - PROCESS | 4339 | Values: 103.0 113.0 115.0 113.0 112.0 118.0 115.0 118.0 114.0 117.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:124.00 stddev:16.60 (13.4%) stddev-sans-first:15.90 23:54:44 INFO - PROCESS | 4339 | Values: 151.0 120.0 120.0 168.0 120.0 123.0 121.0 121.0 138.0 125.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.60 (1.6%) stddev-sans-first:2.76 23:54:44 INFO - PROCESS | 4339 | Values: 164.0 164.0 164.0 163.0 162.0 165.0 171.0 162.0 163.0 163.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.50 stddev:8.91 (11.6%) stddev-sans-first:9.30 23:54:44 INFO - PROCESS | 4339 | Values: 76.0 77.0 77.0 101.0 77.0 76.0 76.0 76.0 93.0 76.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:85.00 stddev:7.27 (8.6%) stddev-sans-first:7.58 23:54:44 INFO - PROCESS | 4339 | Values: 85.0 84.0 102.0 85.0 85.0 85.0 95.0 83.0 84.0 100.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:54:44 INFO - PROCESS | 4339 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 23:54:44 INFO - PROCESS | 4339 | Values: 148.0 149.0 147.0 147.0 148.0 149.0 148.0 148.0 149.0 149.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 23:54:44 INFO - PROCESS | 4339 | Values: 96.0 97.0 96.0 97.0 96.0 96.0 96.0 99.0 97.0 96.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:2.10 (3.6%) stddev-sans-first:2.07 23:54:44 INFO - PROCESS | 4339 | Values: 56.0 56.0 57.0 60.0 62.0 58.0 57.0 61.0 58.0 57.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 23:54:44 INFO - PROCESS | 4339 | Values: 67.0 68.0 68.0 68.0 68.0 67.0 67.0 67.0 67.0 66.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:3.20 (3.9%) stddev-sans-first:3.28 23:54:44 INFO - PROCESS | 4339 | Values: 86.0 82.0 81.0 83.0 90.0 83.0 88.0 82.0 81.0 81.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:137.00 stddev:12.47 (9.1%) stddev-sans-first:13.20 23:54:44 INFO - PROCESS | 4339 | Values: 140.0 137.0 137.0 134.0 127.0 129.0 127.0 134.0 170.0 142.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:172.00 stddev:3.52 (2.0%) stddev-sans-first:3.54 23:54:44 INFO - PROCESS | 4339 | Values: 173.0 172.0 167.0 164.0 166.0 175.0 169.0 172.0 168.0 172.0 23:54:44 INFO - PROCESS | 4339 | 23:54:44 INFO - PROCESS | 4339 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:2.74 (4.2%) stddev-sans-first:2.91 23:54:44 INFO - PROCESS | 4339 | Values: 65.0 65.0 63.0 70.0 63.0 64.0 63.0 66.0 63.0 70.0 23:54:44 INFO - PROCESS | 4339 | -------- Summary: end -------- 23:54:44 INFO - PROCESS | 4339 | 23:54:45 INFO - TEST-INFO | 4339: exit 0 23:54:45 INFO - TEST-OK | kraken | took 61668ms 23:54:45 INFO - SUITE-END | took 1175s 23:54:45 INFO - Completed test suite (00:19:35) 23:54:45 INFO - javascript benchmark 23:54:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7039.249226537686, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.750419966402, 3130.5304204369354, 3137.607799025122, 3158.0683698308994, 3158.5104308832138, 5320.787168513255, 5375.6505827121255, 5389.5688344932405, 5403.0, 5435.592330575213, 5334.066538355792, 5386.380566234884, 5392.137258038714, 5394.460553944604, 5446.618736688433, 4909.116359055369, 4909.852704418864, 4955.08330958772, 5033.899322013557, 5056.797728090872, 4812.23004319309, 4969.676970996874, 4985.501449855004, 4993.251012348141, 5080.415752188509, 4873.415190177201, 4889.926651100236, 4979.004199160165, 5010.849674509771, 5032.2703208035, 4891.266310053485, 4893.559579637814, 4938.38270216223, 4946.9010619787405, 5008.84973450797, 4890.193118135503, 4907.8773030674165, 4914.311996320518, 4915.262710593403, 4926.310316555685, 5309.973450132725, 5419.187121931703, 5442.156465747776, 5466.426025267329, 5473.917891231635, 5735.254416925814, 5764.452377024176, 5856.560757943172, 5859.501942334907, 5992.370801065869, 5965.433283838029, 5967.970160149215, 5970.791022314198, 5983.58114931955, 5985.670788106652, 5531.806386776484, 5544.833654990357, 5546.833594992117, 5548.500634942794, 5548.55611551075, 5842.065269556851, 5889.734961926723, 5931.822045338647, 5938.673372964442, 5978.641281523122, 5661.405552416937, 5743.770249189985, 5757.913631295534, 5782.566307526952, 5804.303483581913, 5814.970925145347, 5820.679862607512, 5835.066389377679, 5869.5010924071075, 5875.441833025856, 5741.282339707536, 5742.167385729046, 5772.191893134965, 5779.075347944393, 5795.1017592273265, 5798.5071268941765, 5813.7383817728305, 5820.417958204146, 5828.59199856006, 5886.23478947734, 4353.281708518059, 4354.912901742011, 4381.583749543788, 4389.561043895585, 4414.381986521889, 3825.540935087807, 3847.2690188864585, 3852.171783066654, 3895.2014836958356, 3920.5687374388795, 5585.804496842591, 5591.07747221712, 5602.075657516546, 5632.155176723442, 5653.321601407857, 5866.413358664099, 5880.764769409261, 5913.994620914455, 5950.047992321294, 5953.583249172603, 5432.348118225759, 5454.481824226692, 5532.944670553324, 5643.40744221859, 5649.152627105967, 4771.165046116985, 4827.08285425768, 4844.249141383091, 4858.271259311061, 4883.267509873547, 6104.908426373608, 6111.327753947062, 6119.449249567471, 6132.172156758869, 6139.570230083851, 5725.742341594721, 5774.133879918046, 5877.089051197071, 5883.264591926009, 5891.823245302648, 6028.3971602839365, 6071.605345652519, 6079.665618391031, 6090.390960904051, 6096.481799046954, 5738.081906894877, 5765.106408506688, 5781.190633311256, 5782.277215348082, 5793.131030345482, 5803.535717142534, 5844.590878638454, 5860.882782344244, 5869.94130058711, 5872.0898260769645, 5694.572907031907, 5726.255586773693, 5729.770809167587, 5749.683767392834, 5783.94216057834, 5676.744546495335, 5716.657000579979, 5744.138379243147, 5751.74117164737, 5752.539796816161, 5521.889562208653, 5595.804146854841, 5608.383077861514, 5667.631603945895, 5704.771809127588, 5745.195672605755, 5752.712364381848, 5752.7698892043845, 5754.712264386848, 5755.107958266475, 5631.521320687623, 5637.379888212211, 5664.745086471036, 5665.12190610456, 5673.375928647928], "value": 5373.840037613117, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.3696911582565, 549.7828357798667, 550.3698265486018, 591.1871177131442, 610.2311088029082, 41100.0, 42598.14803703928, 42625.57374426258, 46040.76979615106, 46191.30713039307, 44812.3278150828, 44870.77564612172, 44939.77530112353, 44941.55058449414, 45095.77452112743, 8924.152205540495, 9088.727338179866, 9097.22673572747, 9105.817883642323, 10037.096661300482, 10045.899541004606, 10047.196224302075, 10066.496675166212, 10086.445245511493, 10152.086312231897, 10143.0, 10224.437655928921, 10249.128824049927, 10252.28234023615, 10264.0, 10093.192544596452, 10118.696439106838, 10153.644622438253, 10172.593096276214, 10236.283460157754, 10013.39919604826, 10062.64780732678, 10068.0, 10077.899221007843, 10108.140808031252, 37548.43677344815, 37838.243235135145, 37893.0, 38041.42937855935, 38113.0, 4024.6919751080723, 4093.2018256440006, 4119.443875076856, 4136.627703506669, 4141.79291035447, 28453.0, 28512.28719282014, 28997.275068123254, 29082.563761543595, 29157.854210729023, 4229.281022226229, 4283.550227226158, 4459.531749166355, 4536.637069034469, 4573.108243892442, 350444.0, 351059.0, 353321.0, 355640.0, 355823.0, 50142.0, 50665.49334506682, 50705.74647126815, 50711.746441267554, 50790.0, 53351.0, 53647.19529207065, 54062.729686352104, 54272.643183920714, 54422.27888605554, 13547.864521354857, 13699.45202191921, 13770.0, 13902.652433689238, 13922.164670119826, 10247.538860751283, 10334.328268662513, 11141.721456963478, 11218.046466050313, 11329.943350283196, 16513.752293715603, 16532.338706451847, 16585.751213731804, 16645.50063498097, 16704.916475417544, 6695.765648202289, 6771.966140169367, 6848.623325717033, 6862.348076932683, 6885.483588730865, 889.822035592884, 893.2764460786783, 895.3016647015338, 899.6941040046415, 923.0861447167256, 28115.43769124606, 28654.14037578876, 29048.273793155342, 29225.0, 29714.554281685792, 1045.4041196518065, 1057.8836328003913, 1079.1636481726568, 1080.438172150493, 1174.4890972427022, 15080.773788393182, 15588.220588970506, 15735.68528629421, 15742.606434839221, 16070.75893861593, 473550.0, 474252.0, 475123.0, 475429.32562755037, 475497.0, 56711.43288567061, 56719.43280567224, 56814.147787783215, 57378.0, 57508.71245643745, 1301.4533895763802, 1324.5893772930615, 1326.2838067443665, 1332.6401871494643, 1370.2600595678223, 28013.579796302663, 29115.272118197216, 29480.557791632713, 29910.953116640812, 30022.84988575043, 48880.51119488759, 49429.25856112089, 49438.25842612292, 49538.50461495339, 49539.0, 389911.0, 392123.0, 393199.0, 393532.0, 394319.0, 23191.88404057969, 23526.294211173692, 23957.28128156158, 24823.0, 27307.86346068257, 38461.615383845805, 38539.807300963315, 38582.22835543217, 38690.0, 39483.802580988064, 32945.0, 32946.0, 33097.50353744648, 33116.62491550387, 33199.66800332062, 31607.525887111253, 31871.521927171576, 32401.0, 32999.0, 33204.335913282084, 31897.840510798225, 32307.35385292328, 32458.0, 32682.50976235406, 34928.82535587306, 27901.302467438476, 28616.42767144604, 32893.67106328906, 33198.83400583078, 33212.50181247235, 25320.493590128463, 25987.870060649577, 26094.73905260923, 26172.73827261703, 26303.4739305209], "value": 18883.835492052913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.97778122203266, 405.7869618450315, 407.60462351519027, 408.97137200395963, 422.1809689202946, 15028.248587570632, 17610.999999999985, 18187.363442279522, 18877.716834247498, 19051.618967620638, 17148.657026859488, 17348.306067757276, 17376.218070186842, 18259.543511412223, 18574.72137917929, 5597.916031259534, 5608.0, 5698.6580805151825, 5737.512311453532, 5800.245968024151, 5598.412166722496, 5640.492355687988, 5679.7160141992945, 5680.261565996435, 5686.687232202227, 5954.9404505955035, 5964.3737407572235, 5969.13447550105, 5979.342272350038, 6012.5791194616395, 5826.475617194473, 5955.808838232328, 5962.642241465504, 5976.282846058479, 5983.640981541122, 5802.796902108406, 5825.155352473867, 5846.766129354821, 5849.385814489502, 5861.794837180721, 14471.78292325616, 14584.927075364662, 21889.67165492519, 22149.557008859734, 22217.666734998988, 2570.9871450642813, 2611.3732704150866, 2658.7607115359515, 2717.3885875677815, 2723.9182824515296, 10286.0, 10296.588136474533, 10515.842262365994, 10675.83986240207, 10788.406637634927, 1961.2547232051872, 1994.524052201375, 1995.6308083004546, 2002.7096071069614, 2017.1527958257568, 68079.0, 74074.25925740728, 74129.0, 74462.62768686176, 76868.0, 10739.301945373525, 10999.450027498593, 11034.558617655204, 11124.165687573464, 11231.326120432801, 12191.573294934635, 12825.23048617086, 15401.691966160839, 15422.614434639, 15493.0, 7631.427642926803, 7656.9234307657325, 7666.65500052499, 7690.653920573588, 7893.644785984645, 7503.399728021745, 7604.8479030419085, 7628.8855667165035, 7814.921850781419, 7867.685292588347, 4103.220388126306, 4113.691473139526, 4170.687198460128, 4182.142660754538, 4238.046439551138, 2000.3498862869626, 2039.0, 2072.9067191976096, 2105.315772373954, 2112.556363163753, 877.1973644115691, 892.3040028777564, 897.264243320471, 903.9502827344559, 936.4100616611491, 16834.831651683573, 17039.14804259807, 17321.56696082583, 17594.38419655306, 17655.38206162778, 916.9679061232824, 921.6405601815297, 923.1091996223677, 923.4044041593269, 925.7731855695398, 9546.618135274512, 9723.270754693427, 9936.254780891462, 10070.496475176213, 10079.092881640687, 372035.0, 377204.0, 381383.0, 382153.0, 385938.0, 74861.0, 76558.0, 77346.6132669333, 77653.0, 78674.0, 972.6449845806371, 981.7447463659357, 1002.3885429887763, 1006.0442579549457, 1008.0776089877826, 15162.545123646309, 15187.848121519086, 15308.387664493295, 15624.375024998873, 15776.447824326093, 26888.462230754885, 35042.29915401729, 36536.0, 37078.0, 37677.0, 47899.52100478951, 48140.7592962047, 48511.0, 48544.271835923195, 50949.7452512735, 8404.36967227448, 8434.409591328547, 8498.660053597787, 8603.52680602573, 8904.777380565538, 10821.296615719953, 12650.557230496888, 12690.302033388252, 12913.289769062792, 12966.740665186831, 10705.411202383631, 10794.406307653155, 11145.665630031112, 11298.548058077586, 11364.659060228207, 6260.68696565179, 7135.785926422215, 9922.305438619516, 10134.645287414905, 10491.580336786443, 11096.944515277371, 11273.492692829006, 11293.887061129284, 11317.0, 11704.473298701749, 8188.877166842622, 8196.83606327882, 8369.874451883348, 8479.19447652472, 8522.190391912758, 9993.800123997626, 11037.0, 11197.384143872165, 11304.773904521699, 11570.537178513101], "value": 8686.027114916118, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.0532934939567, 1389.624801303648, 1399.8600139985997, 1400.6428360768002, 1404.0662959132173, 8026.919730802698, 8310.501369917809, 8478.152184781518, 8562.871556926644, 8581.313494920414, 8530.0, 8669.089745576703, 8673.219410253076, 8709.608067636957, 8746.693865714702, 2290.8854557272152, 2321.3964369263945, 2331.6152834782242, 2333.3233362324904, 2339.2046704120594, 2074.3984244569133, 2134.925277615284, 2142.9892850535803, 2277.9202727904526, 2334.031376978552, 2186.726659167604, 2201.3506015725397, 2208.4258092895884, 2209.3703294561055, 2212.1593794358123, 2204.2175027865037, 2224.110355857662, 2229.342344008521, 2233.2965115988413, 2233.3300009997015, 2235.4634887627017, 2242.932712018642, 2268.092762894839, 2278.9544209115725, 2291.209532711212, 8560.571971401467, 8584.356173287028, 8674.653013879437, 8683.652653893836, 8712.956435217846, 5028.220625803006, 5199.766010529535, 5227.163653815409, 5242.318498595197, 5261.079311120577, 3006.9248268793235, 3206.599175103112, 3260.2012506935953, 3334.7165490933057, 3390.6100798408006, 1418.2837666978214, 1422.3172877018985, 1455.4687539048277, 1468.625500497377, 1481.2149560732828, 11762.705932351673, 11777.528898844035, 11843.940780296129, 11858.16992810495, 11877.940610296979, 4140.751554906655, 4205.8527951522165, 4334.869953901388, 4343.391925130484, 4361.9127617447475, 9184.311176661777, 9194.0, 9215.44707317563, 9230.630774768933, 9244.306676999251, 5123.538881500683, 5155.407128180233, 5163.845084647466, 5167.638265321467, 5168.431472538018, 4716.882077948078, 4742.857714268577, 4772.308015337757, 4792.400949881265, 4808.182608956486, 3488.7440521412273, 3519.489673997256, 3608.675219230282, 3608.675219230282, 3713.440355050885, 1081.0972837680624, 1150.0799360511558, 1163.778882012415, 1185.034197129337, 1189.120051162134, 907.1880666803174, 927.4574373991156, 931.1712575807537, 935.4667839331515, 953.9618415263451, 5393.867287869512, 5411.842934483198, 5447.863803404867, 5503.504684578327, 5544.362398324163, 861.9310455163571, 871.0897112517434, 877.9341549383822, 889.6574818694849, 900.1538553759445, 3612.8735494257576, 3627.9637203628154, 3637.799921004317, 3666.5233519642275, 3695.0577602711137, 9784.119429251401, 9898.950505247427, 10085.546150423248, 10405.9479702601, 10407.375557466576, 10387.532561034772, 10409.895901041044, 10421.478926053667, 10428.739281518023, 10444.582216711246, 7743.264389882952, 7995.880061799077, 8062.637181326854, 8070.798230044178, 8071.4349995500925, 5401.216823560483, 5410.78356865721, 5652.236948012131, 5690.118031705092, 5690.772369105355, 8989.640414383613, 9098.727038188865, 9106.0, 9171.082891710776, 9191.816163676824, 9057.18485336323, 9141.862872056792, 9177.678781242625, 9284.0, 9300.348975571645, 7251.709931602677, 7359.227281135403, 7372.631368431665, 7388.926110738824, 7400.296971787671, 7855.882161767692, 7954.761357159295, 8059.43583949118, 8066.354691624773, 8151.918480815116, 7194.964025179841, 7325.304096110861, 7339.77980660581, 7339.77980660581, 7521.135069467081, 6952.582845029315, 7022.12223472066, 7076.433885289268, 7093.184283807428, 7106.253843346374, 6008.489278411209, 6077.939220607737, 6154.415330543591, 6232.844178895564, 6340.778072767615, 4699.647526435463, 4728.858134255978, 4776.522347765195, 4794.083642307505, 4865.343178670834, 4727.101850648503, 4776.928346074881, 4803.375561177164, 4815.446223684321, 4834.299026641188], "value": 4410.055285355696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.5670449097011, 386.93035253654347, 387.20622723416994, 390.9921801563967, 399.2693371130829, 5212.0, 5295.947040529593, 5302.2311764794085, 5342.0, 5359.222912677665, 5208.453112423198, 5328.973355133228, 5334.51989320961, 5351.7324133793345, 5373.862126162852, 4174.686898482611, 4265.125649241913, 4273.999999999992, 4296.462942132233, 4301.462317210348, 4302.526722060571, 4305.461817272841, 4310.849120280791, 4318.179545886287, 4318.632916202127, 4286.892827679318, 4297.871063868089, 4331.220380331539, 4331.935020974688, 4338.370936214247, 4185.22573323936, 4212.30496968003, 4225.218334608107, 4338.891527711801, 4348.565143485658, 3795.1460921292764, 3815.5802861685193, 3822.541295044585, 3823.63520102311, 3831.214601006787, 5210.374755029383, 5229.50319719626, 5250.212468129773, 5258.13240815265, 5276.947230527722, 4801.5438533339275, 4940.184869496528, 4968.056069346812, 4976.751162441863, 5002.924956125661, 5645.887082258332, 5679.318481782171, 5691.430856914317, 5718.542516598662, 5720.914186287209, 4248.723832950848, 4267.719684094759, 4271.231178387889, 4280.657547396201, 4298.74207547545, 5760.395158508338, 5832.62087964281, 5843.9707801461145, 5946.345901950782, 5966.2840459144745, 4369.2572262714775, 4388.144311859157, 4393.494748104009, 4421.668374871833, 4421.9437961347485, 4459.44256967879, 4483.865484035484, 4491.595756381941, 4500.482444518922, 4525.886852828706, 4804.639652026112, 4907.3620429343955, 4977.502249775066, 5023.598112151019, 5053.5957123430035, 5678.829635110953, 5681.0, 5681.545476361964, 5702.344230413472, 5713.657180569179, 1491.269278053746, 1494.4844028810044, 1504.653929596177, 1512.5613572064199, 1527.3585094260438, 1011.5852500474917, 1080.6379862745912, 1088.8149014667526, 1103.9558417663204, 1112.8593191978125, 5188.714620695822, 5274.391310650289, 5293.655912365684, 5303.602229832778, 5309.097453432925, 5560.833175004756, 5599.2003998001, 5640.858978525488, 5649.68926709035, 5672.419049332544, 5113.974430127825, 5114.820981265638, 5361.973190134025, 5527.309086364205, 5541.790716726265, 3013.9752484155056, 3036.5748795168693, 3054.862531186102, 3058.342456371891, 3061.9081427557207, 5683.8294851153705, 5889.911651325234, 5963.73163207648, 5983.132445795335, 5987.520998320124, 5686.0, 5703.486686198262, 5734.598578099493, 5757.65454072757, 5766.394528574523, 5831.416858314219, 5880.558958078076, 5892.440218179266, 5909.438603332676, 5917.260342457107, 5513.3108361454815, 5543.611947163821, 5579.860503487283, 5799.4780469757925, 5871.1486834407915, 5763.682997435181, 5764.221830052889, 5790.449907258803, 5813.709314534171, 5829.854253643693, 5960.8807823844145, 6074.66589337573, 6117.571769976059, 6128.63228206309, 6187.80332981785, 4135.77253251074, 4157.667386609003, 4161.708680392343, 4177.4778152730905, 4179.916401671889, 5692.743826527899, 5810.4189581041555, 5914.303560274829, 5914.34942156371, 5929.9110513341475, 5681.568376666207, 5687.146927960839, 5687.488126068673, 5692.231548741032, 5697.287839020122, 5665.263515743092, 5692.402297758841, 5719.7426115824055, 5733.627314224562, 5756.510696590837, 5473.0969390050195, 5679.233303503974, 5680.886382272414, 5711.200431939615, 5716.5998380113, 5722.885542289047, 5732.885342293047, 5762.6830524319885, 5770.769169233184, 5782.681952492653, 5325.467453254643, 5629.718514074362, 5647.915281270702, 5669.234653321913, 5689.662929211549], "value": 4387.349437581987, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.740994356947, 752.947293689442, 787.3071696906725, 825.7605294464605, 867.3321542412344, 14319.212443315613, 15633.921830390846, 15672.686546269068, 15677.137757423367, 15753.684926301466, 14739.263036848142, 14970.026948248356, 14991.0, 15020.699586008273, 15544.68910621787, 795.1730200591393, 796.9758859865075, 819.3527113580265, 822.1778221778221, 827.6317038917684, 808.3533173461237, 817.513579420244, 818.0674031603946, 819.6557445872747, 824.5382585751998, 852.2713080316333, 855.8630619100945, 856.6659002988839, 860.6643409070467, 861.1259571534897, 844.9493030418195, 854.3080105114846, 854.363499193099, 857.8927634045745, 860.4493124400389, 624.96875156242, 625.3496363781661, 625.9092431597438, 626.2359920896499, 626.6647343671114, 15921.363145474166, 16000.75998860018, 16151.596210094724, 16450.424235151833, 16536.66926661472, 15438.150901700403, 15653.765193522106, 15654.9217253913, 15796.921015394964, 15926.601834954103, 11654.0, 11764.0, 12345.753084938251, 12355.814662780065, 12456.377181140997, 4572.679912406133, 4638.46657634373, 4665.5567721066445, 4717.103750287469, 4717.386739723848, 78241.0, 78741.0, 80165.19834801636, 80845.0, 80864.19135808684, 11508.734039255674, 11550.0, 11692.123090768226, 11799.52801887915, 11823.467943942544, 21532.78467215339, 21859.0, 22068.0, 22127.557448850934, 22370.44073898133, 7948.602569871483, 8033.156518565466, 8085.231902969209, 8144.0, 8144.144864789112, 4324.113556720865, 4361.651067914623, 4361.934570981438, 4374.234508960919, 4398.780060996937, 3329.8335083245743, 3405.7956522608724, 3405.9829700851337, 3413.4026545354463, 3451.4995325678137, 578.6383510306059, 585.7159277750287, 586.9002269614176, 593.4836692077834, 601.9307779605314, 680.845966087477, 689.7585844954326, 691.9654017299115, 695.2074634916199, 699.618707804248, 8799.69201077972, 9198.770030749285, 9252.352335336462, 9625.759356016155, 9673.613055477703, 658.2134349452358, 667.4126768443739, 670.6546128743603, 677.1163631460893, 701.235653138082, 4129.8967525812095, 4318.093200427883, 4337.0, 4353.782310884443, 4435.112977404532, 78363.60818195986, 78769.0, 79130.6043469779, 79342.6032869832, 79649.0, 68854.65572672104, 69983.65008174926, 71905.2809471909, 72103.63948180225, 72967.63516182386, 62181.58001309881, 65001.67499162474, 66103.0, 66407.0, 66646.66676666682, 8326.70856520019, 8445.155484451505, 8594.636474969433, 8677.956610216908, 8838.602262898057, 42937.35593966155, 43195.78402107969, 43440.56559434365, 43970.0, 44413.55586444094, 53648.73175634097, 53865.73067134639, 54855.451445485036, 55064.44935550593, 55431.722841385534, 11804.586839460577, 12052.51789928393, 12054.276743395425, 12114.15200935926, 12492.188007779465, 12894.29081400532, 12905.548305809252, 12941.627690361242, 13114.344282785632, 13130.540431085248, 11987.580434684744, 12117.27296362221, 12142.575009874965, 12211.0, 12854.935725321313, 12440.626781196579, 12524.37378131108, 12703.174293670882, 12768.808467872803, 12898.290594017419, 11988.940055299669, 11994.520219191134, 12072.154949153475, 12076.939615301868, 12089.093318001009, 10253.58985640566, 10604.734881628021, 10668.09321207675, 10778.461076946278, 11065.059469945145, 9713.611455541699, 10035.795704515212, 10118.13995810335, 10120.59517619287, 10125.797484050425], "value": 7133.024083499086, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 115.0, 113.0, 112.0, 118.0, 115.0, 118.0, 114.0, 117.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 120.0, 168.0, 120.0, 123.0, 121.0, 121.0, 138.0, 125.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 163.0, 162.0, 165.0, 171.0, 162.0, 163.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 101.0, 77.0, 76.0, 76.0, 76.0, 93.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 102.0, 85.0, 85.0, 85.0, 95.0, 83.0, 84.0, 100.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 148.0, 149.0, 148.0, 148.0, 149.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 99.0, 97.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 60.0, 62.0, 58.0, 57.0, 61.0, 58.0, 57.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 66.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 81.0, 83.0, 90.0, 83.0, 88.0, 82.0, 81.0, 81.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 137.0, 137.0, 134.0, 127.0, 129.0, 127.0, 134.0, 170.0, 142.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 167.0, 164.0, 166.0, 175.0, 169.0, 172.0, 168.0, 172.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 70.0, 63.0, 64.0, 63.0, 66.0, 63.0, 70.0], "value": 65.2, "unit": "score"}]}]} 23:54:45 INFO - Return code: 0 23:54:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:54:45 ERROR - # TBPL SUCCESS # 23:54:45 INFO - Running post-action listener: _resource_record_post_action 23:54:45 INFO - [mozharness: 2016-12-30 07:54:45.433052Z] Finished run-tests step (success) 23:54:45 INFO - Running post-run listener: _resource_record_post_run 23:54:45 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408682496; Read time: 472; Write time: 554280 23:54:45 INFO - TinderboxPrint: CPU usage
13.4% 23:54:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 472 23:54:45 INFO - TinderboxPrint: I/O write bytes / time
408,682,496 / 554,280 23:54:45 INFO - TinderboxPrint: CPU idle
8,238.2 (86.5%) 23:54:45 INFO - TinderboxPrint: CPU user
1,216.6 (12.8%) 23:54:45 INFO - TinderboxPrint: Swap in / out
0 / 0 23:54:45 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 111747072; Read time: 0; Write time: 142104 23:54:45 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293400576; Read time: 472; Write time: 411660 23:54:46 INFO - Running post-run listener: _upload_blobber_files 23:54:46 INFO - Blob upload gear active. 23:54:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:54:46 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 23:54:46 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'] 23:54:46 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 23:54:46 INFO - (blobuploader) - INFO - Open directory for files ... 23:54:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:54:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:54:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:54:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:54:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:54:47 INFO - (blobuploader) - INFO - Done attempting. 23:54:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:54:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:54:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:54:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:54:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:54:51 INFO - (blobuploader) - INFO - Done attempting. 23:54:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:54:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:54:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:54:52 INFO - (blobuploader) - INFO - Done attempting. 23:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:54:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:54:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:54:53 INFO - (blobuploader) - INFO - Done attempting. 23:54:53 INFO - (blobuploader) - INFO - Iteration through files over. 23:54:53 INFO - Return code: 0 23:54:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:54:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:54:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/289267cb315b674d953577d9ed9bcb0808d5419d9eb4e9591d040f5e8d48f7574bd552fc60d52881f8776c0cd197cf9656e4fe00900f6ab79812a1368a6fa0f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/613d65330845af5e551a5e0a9dd47fcdee8d3e395cbff0f837ca8b9822b48ff31542440ae672223764e3baa50281d6c3c191bc9172f6abebb094f1ff6c73608c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50691dcdb82e69167015cc46ab998a0e14aeb8b9940e919b44e0357e41aabcfc4d8e826deaa286233033f7af0ad24dc3fdf1ad6193ca74a55dff05200615b99d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3c7344df299abc07de7abbb3ea9ef5e4ce5a9f3316ce296156ed685407fe77da8bf0fed3efd8785f68a61ce0e8b7132297225cbce7d8e70e6ef3168d72a75412"} 23:54:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:54:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:54:53 INFO - Contents: 23:54:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/289267cb315b674d953577d9ed9bcb0808d5419d9eb4e9591d040f5e8d48f7574bd552fc60d52881f8776c0cd197cf9656e4fe00900f6ab79812a1368a6fa0f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/613d65330845af5e551a5e0a9dd47fcdee8d3e395cbff0f837ca8b9822b48ff31542440ae672223764e3baa50281d6c3c191bc9172f6abebb094f1ff6c73608c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50691dcdb82e69167015cc46ab998a0e14aeb8b9940e919b44e0357e41aabcfc4d8e826deaa286233033f7af0ad24dc3fdf1ad6193ca74a55dff05200615b99d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3c7344df299abc07de7abbb3ea9ef5e4ce5a9f3316ce296156ed685407fe77da8bf0fed3efd8785f68a61ce0e8b7132297225cbce7d8e70e6ef3168d72a75412"} 23:54:53 INFO - Running post-run listener: copy_logs_to_upload_dir 23:54:53 INFO - Copying logs to upload dir... 23:54:53 INFO - mkdir: /builds/slave/test/build/upload/logs 23:54:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.832899 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-29 23:54:52.895721) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 23:54:52.901418) ========= 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=5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641 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/289267cb315b674d953577d9ed9bcb0808d5419d9eb4e9591d040f5e8d48f7574bd552fc60d52881f8776c0cd197cf9656e4fe00900f6ab79812a1368a6fa0f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/613d65330845af5e551a5e0a9dd47fcdee8d3e395cbff0f837ca8b9822b48ff31542440ae672223764e3baa50281d6c3c191bc9172f6abebb094f1ff6c73608c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50691dcdb82e69167015cc46ab998a0e14aeb8b9940e919b44e0357e41aabcfc4d8e826deaa286233033f7af0ad24dc3fdf1ad6193ca74a55dff05200615b99d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3c7344df299abc07de7abbb3ea9ef5e4ce5a9f3316ce296156ed685407fe77da8bf0fed3efd8785f68a61ce0e8b7132297225cbce7d8e70e6ef3168d72a75412"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011787 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483062618/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/289267cb315b674d953577d9ed9bcb0808d5419d9eb4e9591d040f5e8d48f7574bd552fc60d52881f8776c0cd197cf9656e4fe00900f6ab79812a1368a6fa0f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/613d65330845af5e551a5e0a9dd47fcdee8d3e395cbff0f837ca8b9822b48ff31542440ae672223764e3baa50281d6c3c191bc9172f6abebb094f1ff6c73608c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50691dcdb82e69167015cc46ab998a0e14aeb8b9940e919b44e0357e41aabcfc4d8e826deaa286233033f7af0ad24dc3fdf1ad6193ca74a55dff05200615b99d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3c7344df299abc07de7abbb3ea9ef5e4ce5a9f3316ce296156ed685407fe77da8bf0fed3efd8785f68a61ce0e8b7132297225cbce7d8e70e6ef3168d72a75412"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 23:54:52.926739) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:54:52.927102) ========= 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=5bd038846534b2fdfa68eeae000001e2-1483083255.416703-2111008641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:54:53.009863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 23:54:53.010186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 23:54:53.010471) ========= ========= Total master_lag: 0.16 =========