builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1484000556.49 results: success (0) buildid: 20170109142235 builduid: c32580d5259f47a8902e716ec63fb0b4 revision: c1f076f55d8c3de786e7e4c96c57567e46297686 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:36.490659) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:36.491480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:36.491757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:36.507064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:36.507464) ========= 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-1484000265.562590-1220045572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 14:22:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2017-01-09 14:22:36 (40.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091376 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:36.613025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:36.613336) ========= 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-1484000265.562590-1220045572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018823 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:36.665817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:36.666604) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c1f076f55d8c3de786e7e4c96c57567e46297686 --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 c1f076f55d8c3de786e7e4c96c57567e46297686 --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-1484000265.562590-1220045572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 14:22:36,938 truncating revision to first 12 chars 2017-01-09 14:22:36,938 Setting DEBUG logging. 2017-01-09 14:22:36,938 attempt 1/10 2017-01-09 14:22:36,939 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c1f076f55d8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 14:22:37,252 unpacking tar archive at: mozilla-inbound-c1f076f55d8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625784 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:37.305543) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:37.305814) ========= script_repo_revision: c1f076f55d8c3de786e7e4c96c57567e46297686 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:37.306520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:37.306782) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 14:22:37.314912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-01-09 14:22:37.315206) ========= /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-1484000265.562590-1220045572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:22:37 INFO - MultiFileLogger online at 20170109 14:22:37 in /builds/slave/test 14:22:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 14:22:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:22:37 INFO - {'append_to_log': False, 14:22:37 INFO - 'base_work_dir': '/builds/slave/test', 14:22:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 14:22:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:22:37 INFO - 'branch': 'Mozilla-Inbound', 14:22:37 INFO - 'buildbot_json_path': 'buildprops.json', 14:22:37 INFO - 'config_files': ('talos/linux_config.py',), 14:22:37 INFO - 'default_actions': ('clobber', 14:22:37 INFO - 'read-buildbot-config', 14:22:37 INFO - 'download-and-extract', 14:22:37 INFO - 'populate-webroot', 14:22:37 INFO - 'create-virtualenv', 14:22:37 INFO - 'install', 14:22:37 INFO - 'run-tests'), 14:22:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:22:37 INFO - 'download_minidump_stackwalk': True, 14:22:37 INFO - 'download_symbols': 'ondemand', 14:22:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:22:37 INFO - 'tooltool.py': '/tools/tooltool.py', 14:22:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:22:37 INFO - '/tools/misc-python/virtualenv.py')}, 14:22:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:22:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:22:37 INFO - 'installer_path': 'installer.exe', 14:22:37 INFO - 'log_level': 'info', 14:22:37 INFO - 'log_name': 'talos', 14:22:37 INFO - 'log_to_console': True, 14:22:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:22:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:22:37 INFO - 'opt_config_files': (), 14:22:37 INFO - 'pip_index': False, 14:22:37 INFO - 'sps_profile': False, 14:22:37 INFO - 'sps_profile_interval': 0, 14:22:37 INFO - 'suite': 'dromaeojs-e10s', 14:22:37 INFO - 'system_bits': '32', 14:22:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:22:37 INFO - 'title': 'talos-linux64-ix-039', 14:22:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:22:37 INFO - 'use_talos_json': True, 14:22:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:22:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:22:37 INFO - 'work_dir': 'build'} 14:22:37 INFO - [mozharness: 2017-01-09 22:22:37.686950Z] Running clobber step. 14:22:37 INFO - Running pre-action listener: _resource_record_pre_action 14:22:37 INFO - Running main action method: clobber 14:22:37 INFO - rmtree: /builds/slave/test/build 14:22:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:22:38 INFO - Running post-action listener: _resource_record_post_action 14:22:38 INFO - [mozharness: 2017-01-09 22:22:38.660337Z] Finished clobber step (success) 14:22:38 INFO - [mozharness: 2017-01-09 22:22:38.660436Z] Running read-buildbot-config step. 14:22:38 INFO - Running pre-action listener: _resource_record_pre_action 14:22:38 INFO - Running main action method: read_buildbot_config 14:22:38 INFO - Using buildbot properties: 14:22:38 INFO - { 14:22:38 INFO - "project": "", 14:22:38 INFO - "product": "firefox", 14:22:38 INFO - "script_repo_revision": "production", 14:22:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 14:22:38 INFO - "repository": "", 14:22:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 14:22:38 INFO - "buildid": "20170109142235", 14:22:38 INFO - "stage_platform": "linux64-pgo", 14:22:38 INFO - "basedir": "/builds/slave/test", 14:22:38 INFO - "buildnumber": 2234, 14:22:38 INFO - "platform": "ubuntu64_hw", 14:22:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:22:38 INFO - "slavebuilddir": "test", 14:22:38 INFO - "branch": "mozilla-inbound", 14:22:38 INFO - "revision": "c1f076f55d8c3de786e7e4c96c57567e46297686", 14:22:38 INFO - "slavename": "talos-linux64-ix-039", 14:22:38 INFO - "builduid": "c32580d5259f47a8902e716ec63fb0b4", 14:22:38 INFO - "repo_path": "integration/mozilla-inbound" 14:22:38 INFO - } 14:22:38 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 14:22:38 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 14:22:38 INFO - Running post-action listener: _resource_record_post_action 14:22:38 INFO - [mozharness: 2017-01-09 22:22:38.662817Z] Finished read-buildbot-config step (success) 14:22:38 INFO - [mozharness: 2017-01-09 22:22:38.662905Z] Running download-and-extract step. 14:22:38 INFO - Running pre-action listener: _resource_record_pre_action 14:22:38 INFO - Running main action method: download_and_extract 14:22:38 INFO - mkdir: /builds/slave/test/build/tests 14:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:38 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:22:38 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/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 14:22:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/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 14:22:39 INFO - Downloaded 1361 bytes. 14:22:39 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:22:39 INFO - Using the following test package requirements: 14:22:39 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:22:39 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:22:39 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:22:39 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:39 INFO - u'jsshell-linux-x86_64.zip'], 14:22:39 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:22:39 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:22:39 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:22:39 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:22:39 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:22:39 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:22:39 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:22:39 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/1483994107/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:22:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:22:39 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:22:42 INFO - Expected file size: 21843148 14:22:42 INFO - Obtained file size: 21843148 14:22:46 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 14:22:46 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/1483994107/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:22:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:22:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:22:47 INFO - Expected file size: 21843148 14:22:47 INFO - Obtained file size: 21843148 14:22:51 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/1483994107/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 14:22:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:22:51 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:22:55 INFO - Expected file size: 14403529 14:22:55 INFO - Obtained file size: 14403529 14:22:55 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')]} 14:22:55 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:22:55 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/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 14:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/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 14:23:01 INFO - Downloaded 61460290 bytes. 14:23:01 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:23:01 INFO - mkdir: /builds/slave/test/properties 14:23:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:23:01 INFO - Writing to file /builds/slave/test/properties/build_url 14:23:01 INFO - Contents: 14:23:01 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:23:02 INFO - Running post-action listener: _resource_record_post_action 14:23:02 INFO - Running post-action listener: set_extra_try_arguments 14:23:02 INFO - [mozharness: 2017-01-09 22:23:02.381875Z] Finished download-and-extract step (success) 14:23:02 INFO - [mozharness: 2017-01-09 22:23:02.382104Z] Running populate-webroot step. 14:23:02 INFO - Running pre-action listener: _resource_record_pre_action 14:23:02 INFO - Running main action method: populate_webroot 14:23:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:23:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:23:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:23:02 INFO - '--tppagecycles', 14:23:02 INFO - '7'], 14:23:02 INFO - 'tests': ['tsvgm']}}, 14:23:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:23:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:23:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:23:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:23:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:23:02 INFO - 'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:23:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:23:02 INFO - 'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['damp', 'tps']}, 14:23:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:23:02 INFO - 'tests': ['damp', 'tps']}, 14:23:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['dromaeo_dom']}, 14:23:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:23:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['basic_compositor_video']}, 14:23:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:23:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['a11yr', 14:23:02 INFO - 'ts_paint', 14:23:02 INFO - 'tpaint', 14:23:02 INFO - 'sessionrestore', 14:23:02 INFO - 'sessionrestore_no_auto_restore', 14:23:02 INFO - 'tabpaint']}, 14:23:02 INFO - 'other-e10s': {'tests': ['a11yr', 14:23:02 INFO - 'ts_paint', 14:23:02 INFO - 'tpaint', 14:23:02 INFO - 'sessionrestore', 14:23:02 INFO - 'sessionrestore_no_auto_restore', 14:23:02 INFO - 'tabpaint']}, 14:23:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:23:02 INFO - 'ts_paint', 14:23:02 INFO - 'tpaint', 14:23:02 INFO - 'sessionrestore', 14:23:02 INFO - 'sessionrestore_no_auto_restore', 14:23:02 INFO - 'tabpaint']}, 14:23:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:23:02 INFO - 'ts_paint', 14:23:02 INFO - 'tpaint', 14:23:02 INFO - 'sessionrestore', 14:23:02 INFO - 'sessionrestore_no_auto_restore', 14:23:02 INFO - 'tabpaint']}, 14:23:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['a11yr', 14:23:02 INFO - 'ts_paint', 14:23:02 INFO - 'tpaint', 14:23:02 INFO - 'sessionrestore', 14:23:02 INFO - 'sessionrestore_no_auto_restore', 14:23:02 INFO - 'tabpaint']}, 14:23:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['a11yr', 14:23:02 INFO - 'ts_paint', 14:23:02 INFO - 'tpaint', 14:23:02 INFO - 'sessionrestore', 14:23:02 INFO - 'sessionrestore_no_auto_restore', 14:23:02 INFO - 'tabpaint']}, 14:23:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['tsvgx', 14:23:02 INFO - 'tsvgr_opacity', 14:23:02 INFO - 'tart', 14:23:02 INFO - 'tscrollx', 14:23:02 INFO - 'cart', 14:23:02 INFO - 'tsvg_static']}, 14:23:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:23:02 INFO - 'tsvgr_opacity', 14:23:02 INFO - 'tart', 14:23:02 INFO - 'tscrollx', 14:23:02 INFO - 'cart', 14:23:02 INFO - 'tsvg_static']}, 14:23:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:23:02 INFO - 'talos_options': ['--disable-e10s'], 14:23:02 INFO - 'tests': ['tp5o']}, 14:23:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:23:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:23:02 INFO - 'talos_options': ['--disable-e10s', 14:23:02 INFO - '--xperf_path', 14:23:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:02 INFO - 'tests': ['tp5n']}, 14:23:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:23:02 INFO - 'talos_options': ['--xperf_path', 14:23:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:02 INFO - 'tests': ['tp5n']}}, 14:23:02 INFO - 'talos.zip': {'path': '', 14:23:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:23:02 INFO - Running post-action listener: _resource_record_post_action 14:23:02 INFO - [mozharness: 2017-01-09 22:23:02.402976Z] Finished populate-webroot step (success) 14:23:02 INFO - [mozharness: 2017-01-09 22:23:02.403065Z] Running create-virtualenv step. 14:23:02 INFO - Running pre-action listener: _resource_record_pre_action 14:23:02 INFO - Running main action method: create_virtualenv 14:23:02 INFO - Creating virtualenv /builds/slave/test/build/venv 14:23:02 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 14:23:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:23:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:23:02 INFO - Using real prefix '/usr' 14:23:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:23:03 INFO - Installing distribute.............................................................................................................................................................................................done. 14:23:04 INFO - Installing pip.................done. 14:23:04 INFO - Return code: 0 14:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:23:05 INFO - Reading from file tmpfile_stdout 14:23:05 INFO - Output received: 14:23:05 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) 14:23:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:05 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 0x11e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, '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-1484000265.562590-1220045572', '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 14:23:05 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 14:23:05 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 14:23:05 INFO - Using env: {'DISPLAY': ':0', 14:23:05 INFO - 'HOME': '/home/cltbld', 14:23:05 INFO - 'LANG': 'en_US.UTF-8', 14:23:05 INFO - 'LANGUAGE': 'en_US:en', 14:23:05 INFO - 'LOGNAME': 'cltbld', 14:23:05 INFO - 'MAIL': '/var/mail/cltbld', 14:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:05 INFO - 'MOZ_NO_REMOTE': '1', 14:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:05 INFO - 'NO_EM_RESTART': '1', 14:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:05 INFO - 'PWD': '/builds/slave/test', 14:23:05 INFO - 'SHELL': '/bin/bash', 14:23:05 INFO - 'SHLVL': '1', 14:23:05 INFO - 'TERM': 'linux', 14:23:05 INFO - 'TMOUT': '86400', 14:23:05 INFO - 'USER': 'cltbld', 14:23:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:05 INFO - '_': '/tools/buildbot/bin/python'} 14:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:05 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 14:23:05 INFO - Cleaning up... 14:23:05 INFO - Return code: 0 14:23:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:05 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 0x11e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, '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-1484000265.562590-1220045572', '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 14:23:05 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 14:23:05 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 14:23:05 INFO - Using env: {'DISPLAY': ':0', 14:23:05 INFO - 'HOME': '/home/cltbld', 14:23:05 INFO - 'LANG': 'en_US.UTF-8', 14:23:05 INFO - 'LANGUAGE': 'en_US:en', 14:23:05 INFO - 'LOGNAME': 'cltbld', 14:23:05 INFO - 'MAIL': '/var/mail/cltbld', 14:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:05 INFO - 'MOZ_NO_REMOTE': '1', 14:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:05 INFO - 'NO_EM_RESTART': '1', 14:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:05 INFO - 'PWD': '/builds/slave/test', 14:23:05 INFO - 'SHELL': '/bin/bash', 14:23:05 INFO - 'SHLVL': '1', 14:23:05 INFO - 'TERM': 'linux', 14:23:05 INFO - 'TMOUT': '86400', 14:23:05 INFO - 'USER': 'cltbld', 14:23:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:05 INFO - '_': '/tools/buildbot/bin/python'} 14:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:05 INFO - Downloading/unpacking psutil>=3.1.1 14:23:05 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 14:23:05 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 14:23:05 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 14:23:05 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 14:23:05 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 14:23:05 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 14:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:23:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:07 INFO - Installing collected packages: psutil 14:23:07 INFO - Running setup.py install for psutil 14:23:07 INFO - building 'psutil._psutil_linux' extension 14:23:07 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 14:23:08 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 14:23:08 INFO - building 'psutil._psutil_posix' extension 14:23:08 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 14:23:08 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 14:23:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:08 INFO - Successfully installed psutil 14:23:08 INFO - Cleaning up... 14:23:08 INFO - Return code: 0 14:23:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:08 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 0x11e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, '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-1484000265.562590-1220045572', '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 14:23:08 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 14:23:08 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 14:23:08 INFO - Using env: {'DISPLAY': ':0', 14:23:08 INFO - 'HOME': '/home/cltbld', 14:23:08 INFO - 'LANG': 'en_US.UTF-8', 14:23:08 INFO - 'LANGUAGE': 'en_US:en', 14:23:08 INFO - 'LOGNAME': 'cltbld', 14:23:08 INFO - 'MAIL': '/var/mail/cltbld', 14:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:08 INFO - 'MOZ_NO_REMOTE': '1', 14:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:08 INFO - 'NO_EM_RESTART': '1', 14:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:08 INFO - 'PWD': '/builds/slave/test', 14:23:08 INFO - 'SHELL': '/bin/bash', 14:23:08 INFO - 'SHLVL': '1', 14:23:08 INFO - 'TERM': 'linux', 14:23:08 INFO - 'TMOUT': '86400', 14:23:08 INFO - 'USER': 'cltbld', 14:23:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:08 INFO - '_': '/tools/buildbot/bin/python'} 14:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:23:10 INFO - Installing collected packages: mozsystemmonitor 14:23:10 INFO - Running setup.py install for mozsystemmonitor 14:23:10 INFO - Successfully installed mozsystemmonitor 14:23:10 INFO - Cleaning up... 14:23:10 INFO - Return code: 0 14:23:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, '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-1484000265.562590-1220045572', '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 14:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:23:10 INFO - Using env: {'DISPLAY': ':0', 14:23:10 INFO - 'HOME': '/home/cltbld', 14:23:10 INFO - 'LANG': 'en_US.UTF-8', 14:23:10 INFO - 'LANGUAGE': 'en_US:en', 14:23:10 INFO - 'LOGNAME': 'cltbld', 14:23:10 INFO - 'MAIL': '/var/mail/cltbld', 14:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:10 INFO - 'MOZ_NO_REMOTE': '1', 14:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:10 INFO - 'NO_EM_RESTART': '1', 14:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:10 INFO - 'PWD': '/builds/slave/test', 14:23:10 INFO - 'SHELL': '/bin/bash', 14:23:10 INFO - 'SHLVL': '1', 14:23:10 INFO - 'TERM': 'linux', 14:23:10 INFO - 'TMOUT': '86400', 14:23:10 INFO - 'USER': 'cltbld', 14:23:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:10 INFO - '_': '/tools/buildbot/bin/python'} 14:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:10 INFO - Downloading/unpacking jsonschema==2.5.1 14:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:23:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:23:12 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 14:23:12 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 14:23:12 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 14:23:12 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 14:23:12 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 14:23:12 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 14:23:13 INFO - Downloading functools32-3.2.3-2.tar.gz 14:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:23:13 INFO - warning: no files found matching '*.txt' 14:23:13 INFO - no previously-included directories found matching 'build' 14:23:13 INFO - no previously-included directories found matching 'dist' 14:23:13 INFO - no previously-included directories found matching '.git*' 14:23:13 INFO - Installing collected packages: jsonschema, functools32 14:23:13 INFO - Running setup.py install for functools32 14:23:13 INFO - warning: no files found matching '*.txt' 14:23:13 INFO - no previously-included directories found matching 'build' 14:23:13 INFO - no previously-included directories found matching 'dist' 14:23:13 INFO - no previously-included directories found matching '.git*' 14:23:13 INFO - Successfully installed jsonschema functools32 14:23:13 INFO - Cleaning up... 14:23:13 INFO - Return code: 0 14:23:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, '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-1484000265.562590-1220045572', '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 14:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:23:13 INFO - Using env: {'DISPLAY': ':0', 14:23:13 INFO - 'HOME': '/home/cltbld', 14:23:13 INFO - 'LANG': 'en_US.UTF-8', 14:23:13 INFO - 'LANGUAGE': 'en_US:en', 14:23:13 INFO - 'LOGNAME': 'cltbld', 14:23:13 INFO - 'MAIL': '/var/mail/cltbld', 14:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:13 INFO - 'MOZ_NO_REMOTE': '1', 14:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:13 INFO - 'NO_EM_RESTART': '1', 14:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:13 INFO - 'PWD': '/builds/slave/test', 14:23:13 INFO - 'SHELL': '/bin/bash', 14:23:13 INFO - 'SHLVL': '1', 14:23:13 INFO - 'TERM': 'linux', 14:23:13 INFO - 'TMOUT': '86400', 14:23:13 INFO - 'USER': 'cltbld', 14:23:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:13 INFO - '_': '/tools/buildbot/bin/python'} 14:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:23:13 INFO - Cleaning up... 14:23:13 INFO - Return code: 0 14:23:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, '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-1484000265.562590-1220045572', '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 14:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:23:13 INFO - Using env: {'DISPLAY': ':0', 14:23:13 INFO - 'HOME': '/home/cltbld', 14:23:13 INFO - 'LANG': 'en_US.UTF-8', 14:23:13 INFO - 'LANGUAGE': 'en_US:en', 14:23:13 INFO - 'LOGNAME': 'cltbld', 14:23:13 INFO - 'MAIL': '/var/mail/cltbld', 14:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:13 INFO - 'MOZ_NO_REMOTE': '1', 14:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:13 INFO - 'NO_EM_RESTART': '1', 14:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:13 INFO - 'PWD': '/builds/slave/test', 14:23:13 INFO - 'SHELL': '/bin/bash', 14:23:13 INFO - 'SHLVL': '1', 14:23:13 INFO - 'TERM': 'linux', 14:23:13 INFO - 'TMOUT': '86400', 14:23:13 INFO - 'USER': 'cltbld', 14:23:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:13 INFO - '_': '/tools/buildbot/bin/python'} 14:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:13 INFO - Downloading/unpacking blobuploader==1.2.4 14:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:15 INFO - Downloading blobuploader-1.2.4.tar.gz 14:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:23:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:23:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:23:16 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 14:23:16 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 14:23:16 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 14:23:16 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 14:23:16 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 14:23:16 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 14:23:16 INFO - Downloading docopt-0.6.1.tar.gz 14:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:23:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:23:16 INFO - Running setup.py install for blobuploader 14:23:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:23:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:23:16 INFO - Running setup.py install for requests 14:23:17 INFO - Running setup.py install for docopt 14:23:17 INFO - Successfully installed blobuploader requests docopt 14:23:17 INFO - Cleaning up... 14:23:17 INFO - Return code: 0 14:23:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:17 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 0x11e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, '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-1484000265.562590-1220045572', '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 14:23:17 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 14:23:17 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 14:23:17 INFO - Using env: {'DISPLAY': ':0', 14:23:17 INFO - 'HOME': '/home/cltbld', 14:23:17 INFO - 'LANG': 'en_US.UTF-8', 14:23:17 INFO - 'LANGUAGE': 'en_US:en', 14:23:17 INFO - 'LOGNAME': 'cltbld', 14:23:17 INFO - 'MAIL': '/var/mail/cltbld', 14:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:17 INFO - 'MOZ_NO_REMOTE': '1', 14:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:17 INFO - 'NO_EM_RESTART': '1', 14:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:17 INFO - 'PWD': '/builds/slave/test', 14:23:17 INFO - 'SHELL': '/bin/bash', 14:23:17 INFO - 'SHLVL': '1', 14:23:17 INFO - 'TERM': 'linux', 14:23:17 INFO - 'TMOUT': '86400', 14:23:17 INFO - 'USER': 'cltbld', 14:23:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:17 INFO - '_': '/tools/buildbot/bin/python'} 14:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:17 INFO - Running setup.py (path:/tmp/pip-Rdwa8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:17 INFO - Running setup.py (path:/tmp/pip-TtAkDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:17 INFO - Running setup.py (path:/tmp/pip-zxIi7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:17 INFO - Running setup.py (path:/tmp/pip-CCk2Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:17 INFO - Running setup.py (path:/tmp/pip-hl9KMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:17 INFO - Running setup.py (path:/tmp/pip-_uBGGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:18 INFO - Running setup.py (path:/tmp/pip-4g4ELT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:18 INFO - Running setup.py (path:/tmp/pip-IdLcb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:18 INFO - Running setup.py (path:/tmp/pip-cbOdIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:18 INFO - Running setup.py (path:/tmp/pip-3tuwRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:18 INFO - Running setup.py (path:/tmp/pip-BXxkGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:18 INFO - Running setup.py (path:/tmp/pip-UFyNIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:18 INFO - Running setup.py (path:/tmp/pip-o88avh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:18 INFO - Running setup.py (path:/tmp/pip-PD02KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:18 INFO - Running setup.py (path:/tmp/pip-Tcbofw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:18 INFO - Running setup.py (path:/tmp/pip-ZSnSqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:18 INFO - Running setup.py (path:/tmp/pip-YqGr58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:23:18 INFO - Running setup.py install for manifestparser 14:23:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:23:18 INFO - Running setup.py install for mozcrash 14:23:19 INFO - Running setup.py install for mozdebug 14:23:19 INFO - Running setup.py install for mozdevice 14:23:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:23:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:23:19 INFO - Running setup.py install for mozfile 14:23:19 INFO - Running setup.py install for mozhttpd 14:23:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:23:19 INFO - Running setup.py install for mozinfo 14:23:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:23:19 INFO - Running setup.py install for mozInstall 14:23:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:23:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:23:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:23:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:23:19 INFO - Running setup.py install for mozleak 14:23:19 INFO - Running setup.py install for mozlog 14:23:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:23:19 INFO - Running setup.py install for moznetwork 14:23:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:23:19 INFO - Running setup.py install for mozprocess 14:23:20 INFO - Running setup.py install for mozprofile 14:23:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:23:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:23:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:23:20 INFO - Running setup.py install for mozrunner 14:23:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:23:20 INFO - Running setup.py install for mozscreenshot 14:23:20 INFO - Running setup.py install for moztest 14:23:20 INFO - Running setup.py install for mozversion 14:23:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:23:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:23:20 INFO - Cleaning up... 14:23:20 INFO - Return code: 0 14:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:20 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')]} 14:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:20 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')]} 14:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:20 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 0x11e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, '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-1484000265.562590-1220045572', '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 14:23:20 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 14:23:20 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 14:23:20 INFO - Using env: {'DISPLAY': ':0', 14:23:20 INFO - 'HOME': '/home/cltbld', 14:23:20 INFO - 'LANG': 'en_US.UTF-8', 14:23:20 INFO - 'LANGUAGE': 'en_US:en', 14:23:20 INFO - 'LOGNAME': 'cltbld', 14:23:20 INFO - 'MAIL': '/var/mail/cltbld', 14:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:20 INFO - 'MOZ_NO_REMOTE': '1', 14:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:20 INFO - 'NO_EM_RESTART': '1', 14:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:20 INFO - 'PWD': '/builds/slave/test', 14:23:20 INFO - 'SHELL': '/bin/bash', 14:23:20 INFO - 'SHLVL': '1', 14:23:20 INFO - 'TERM': 'linux', 14:23:20 INFO - 'TMOUT': '86400', 14:23:20 INFO - 'USER': 'cltbld', 14:23:20 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:20 INFO - '_': '/tools/buildbot/bin/python'} 14:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:20 INFO - Running setup.py (path:/tmp/pip-9RstcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:20 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)) 14:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:20 INFO - Running setup.py (path:/tmp/pip-pTFPzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:21 INFO - Running setup.py (path:/tmp/pip-I1FP7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:21 INFO - Running setup.py (path:/tmp/pip-ANhUSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:21 INFO - Running setup.py (path:/tmp/pip-S_0_nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:21 INFO - Running setup.py (path:/tmp/pip-Pys15B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:21 INFO - Running setup.py (path:/tmp/pip-vsFt1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:21 INFO - Running setup.py (path:/tmp/pip-_IohGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:21 INFO - Running setup.py (path:/tmp/pip-CqRZM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:21 INFO - Running setup.py (path:/tmp/pip-vYxiDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:21 INFO - Running setup.py (path:/tmp/pip-jR0PnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:21 INFO - Running setup.py (path:/tmp/pip-0G22L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:21 INFO - Running setup.py (path:/tmp/pip-Ld66WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:21 INFO - Running setup.py (path:/tmp/pip-VZTUTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:21 INFO - Running setup.py (path:/tmp/pip-vxp2JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:21 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)) 14:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:21 INFO - Running setup.py (path:/tmp/pip-8Q2hJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:22 INFO - Running setup.py (path:/tmp/pip-96c_IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:22 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)) 14:23:22 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)) 14:23:22 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)) 14:23:22 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)) 14:23:22 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)) 14:23:22 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)) 14:23:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:22 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 14:23:22 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 14:23:22 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 14:23:22 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 14:23:22 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 14:23:22 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 14:23:24 INFO - Downloading blessings-1.6.tar.gz 14:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:23:24 INFO - Installing collected packages: blessings 14:23:24 INFO - Running setup.py install for blessings 14:23:24 INFO - Successfully installed blessings 14:23:24 INFO - Cleaning up... 14:23:24 INFO - Return code: 0 14:23:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:23:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:24 INFO - Reading from file tmpfile_stdout 14:23:24 INFO - Current package versions: 14:23:24 INFO - argparse == 1.2.1 14:23:24 INFO - blessings == 1.6 14:23:24 INFO - blobuploader == 1.2.4 14:23:24 INFO - docopt == 0.6.1 14:23:24 INFO - functools32 == 3.2.3-2 14:23:24 INFO - jsonschema == 2.5.1 14:23:24 INFO - manifestparser == 1.1 14:23:24 INFO - mozInstall == 1.12 14:23:24 INFO - mozcrash == 1.0 14:23:24 INFO - mozdebug == 0.1 14:23:24 INFO - mozdevice == 0.49 14:23:24 INFO - mozfile == 1.2 14:23:24 INFO - mozhttpd == 0.7 14:23:24 INFO - mozinfo == 0.9 14:23:24 INFO - mozleak == 0.1 14:23:24 INFO - mozlog == 3.4 14:23:24 INFO - moznetwork == 0.27 14:23:24 INFO - mozprocess == 0.24 14:23:24 INFO - mozprofile == 0.28 14:23:24 INFO - mozrunner == 6.13 14:23:24 INFO - mozscreenshot == 0.1 14:23:24 INFO - mozsystemmonitor == 0.3 14:23:24 INFO - moztest == 0.8 14:23:24 INFO - mozversion == 1.4 14:23:24 INFO - psutil == 3.1.1 14:23:24 INFO - requests == 1.2.3 14:23:24 INFO - wsgiref == 0.1.2 14:23:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:24 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 0x11e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, '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-1484000265.562590-1220045572', '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 14:23:24 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 14:23:24 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 14:23:24 INFO - Using env: {'DISPLAY': ':0', 14:23:24 INFO - 'HOME': '/home/cltbld', 14:23:24 INFO - 'LANG': 'en_US.UTF-8', 14:23:24 INFO - 'LANGUAGE': 'en_US:en', 14:23:24 INFO - 'LOGNAME': 'cltbld', 14:23:24 INFO - 'MAIL': '/var/mail/cltbld', 14:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:24 INFO - 'MOZ_NO_REMOTE': '1', 14:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:24 INFO - 'NO_EM_RESTART': '1', 14:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:24 INFO - 'PWD': '/builds/slave/test', 14:23:24 INFO - 'SHELL': '/bin/bash', 14:23:24 INFO - 'SHLVL': '1', 14:23:24 INFO - 'TERM': 'linux', 14:23:24 INFO - 'TMOUT': '86400', 14:23:24 INFO - 'USER': 'cltbld', 14:23:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:24 INFO - '_': '/tools/buildbot/bin/python'} 14:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:24 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)) 14:23:24 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)) 14:23:24 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)) 14:23:24 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)) 14:23:24 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)) 14:23:24 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)) 14:23:24 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)) 14:23:24 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)) 14:23:24 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)) 14:23:24 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)) 14:23:24 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)) 14:23:24 INFO - Cleaning up... 14:23:24 INFO - Return code: 0 14:23:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, '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-1484000265.562590-1220045572', '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 14:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:23:24 INFO - Using env: {'DISPLAY': ':0', 14:23:24 INFO - 'HOME': '/home/cltbld', 14:23:24 INFO - 'LANG': 'en_US.UTF-8', 14:23:24 INFO - 'LANGUAGE': 'en_US:en', 14:23:24 INFO - 'LOGNAME': 'cltbld', 14:23:24 INFO - 'MAIL': '/var/mail/cltbld', 14:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:24 INFO - 'MOZ_NO_REMOTE': '1', 14:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:24 INFO - 'NO_EM_RESTART': '1', 14:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:24 INFO - 'PWD': '/builds/slave/test', 14:23:24 INFO - 'SHELL': '/bin/bash', 14:23:24 INFO - 'SHLVL': '1', 14:23:24 INFO - 'TERM': 'linux', 14:23:24 INFO - 'TMOUT': '86400', 14:23:24 INFO - 'USER': 'cltbld', 14:23:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:24 INFO - '_': '/tools/buildbot/bin/python'} 14:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:23:25 INFO - Cleaning up... 14:23:25 INFO - Return code: 0 14:23:25 INFO - Running post-action listener: _resource_record_post_action 14:23:25 INFO - Running post-action listener: _start_resource_monitoring 14:23:25 INFO - Starting resource monitoring. 14:23:25 INFO - [mozharness: 2017-01-09 22:23:25.127301Z] Finished create-virtualenv step (success) 14:23:25 INFO - [mozharness: 2017-01-09 22:23:25.127772Z] Running install step. 14:23:25 INFO - Running pre-action listener: _resource_record_pre_action 14:23:25 INFO - Running main action method: install 14:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:25 INFO - Reading from file tmpfile_stdout 14:23:25 INFO - Detecting whether we're running mozinstall >=1.0... 14:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:23:25 INFO - Reading from file tmpfile_stdout 14:23:25 INFO - Output received: 14:23:25 INFO - Usage: mozinstall [options] installer 14:23:25 INFO - Options: 14:23:25 INFO - -h, --help show this help message and exit 14:23:25 INFO - -d DEST, --destination=DEST 14:23:25 INFO - Directory to install application into. [default: 14:23:25 INFO - "/builds/slave/test"] 14:23:25 INFO - --app=APP Application being installed. [default: firefox] 14:23:25 INFO - mkdir: /builds/slave/test/build/application 14:23:25 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'] 14:23:25 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 14:23:42 INFO - Reading from file tmpfile_stdout 14:23:42 INFO - Output received: 14:23:42 INFO - /builds/slave/test/build/application/firefox/firefox 14:23:42 INFO - Running post-action listener: _resource_record_post_action 14:23:42 INFO - [mozharness: 2017-01-09 22:23:42.786920Z] Finished install step (success) 14:23:42 INFO - [mozharness: 2017-01-09 22:23:42.787193Z] Running run-tests step. 14:23:42 INFO - Running pre-action listener: _resource_record_pre_action 14:23:42 INFO - Running main action method: run_tests 14:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:23:42 INFO - Python 2.7.3 14:23:42 INFO - Return code: 0 14:23:42 INFO - grabbing minidump binary from tooltool 14:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:42 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 0x154f820>, '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 0x1550520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15509b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:23:42 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 14:23:42 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 14:23:42 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 14:23:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:23:42 INFO - Return code: 0 14:23:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:23:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:23:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:23:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:23:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:23:42 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/1483994107/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 14:23:42 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/1483994107/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 14:23:42 INFO - Using env: {'DISPLAY': ':0', 14:23:42 INFO - 'HOME': '/home/cltbld', 14:23:42 INFO - 'LANG': 'en_US.UTF-8', 14:23:42 INFO - 'LANGUAGE': 'en_US:en', 14:23:42 INFO - 'LOGNAME': 'cltbld', 14:23:42 INFO - 'MAIL': '/var/mail/cltbld', 14:23:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:23:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:42 INFO - 'MOZ_NO_REMOTE': '1', 14:23:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:23:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:42 INFO - 'NO_EM_RESTART': '1', 14:23:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:42 INFO - 'PWD': '/builds/slave/test', 14:23:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:23:42 INFO - 'SHELL': '/bin/bash', 14:23:42 INFO - 'SHLVL': '1', 14:23:42 INFO - 'TERM': 'linux', 14:23:42 INFO - 'TMOUT': '86400', 14:23:42 INFO - 'USER': 'cltbld', 14:23:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484000265.562590-1220045572', 14:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:42 INFO - '_': '/tools/buildbot/bin/python'} 14:23:42 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/1483994107/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 14:23:43 INFO - mozversion application_buildid: 20170109123507 14:23:43 INFO - mozversion application_changeset: c1f076f55d8c3de786e7e4c96c57567e46297686 14:23:43 INFO - mozversion application_display_name: Nightly 14:23:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:23:43 INFO - mozversion application_name: Firefox 14:23:43 INFO - mozversion application_remotingname: firefox 14:23:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:23:43 INFO - mozversion application_vendor: Mozilla 14:23:43 INFO - mozversion application_version: 53.0a1 14:23:43 INFO - mozversion platform_buildid: 20170109123507 14:23:43 INFO - mozversion platform_changeset: c1f076f55d8c3de786e7e4c96c57567e46297686 14:23:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:23:43 INFO - mozversion platform_version: 53.0a1 14:23:43 INFO - using testdate: 1484000623 14:23:43 INFO - actual date: 1484000623 14:23:43 INFO - starting webserver on 'localhost:60015' 14:23:43 INFO - SUITE-START | Running 2 tests 14:23:43 INFO - TEST-START | dromaeo_css 14:23:43 INFO - operating with platform_type : linux_ 14:23:43 INFO - Initialising browser for dromaeo_css test... 14:23:43 INFO - TEST-INFO | started process 26904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaEfJvW/profile http://localhost:60015/getInfo.html) 14:23:43 INFO - PROCESS | 26904 | 1484000623541 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:4905 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3760 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2793 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 14:23:47 INFO - PROCESS | 26904 | __metrics Screen width/height:1600/1200 14:23:47 INFO - PROCESS | 26904 | colorDepth:24 14:23:47 INFO - PROCESS | 26904 | Browser inner width/height: 1024/697 14:23:47 INFO - PROCESS | 26904 | __metrics 14:23:48 ERROR - PROCESS | 26904 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 14:23:48 INFO - TEST-INFO | 26904: exit 0 14:23:48 INFO - Browser initialized. 14:23:48 INFO - Running cycle 1/1 for dromaeo_css test... 14:23:48 INFO - TEST-INFO | started process 27029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaEfJvW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:00 INFO - PROCESS | 27029 | RSS: Main: 155537408 14:24:00 INFO - PROCESS | 27029 | 14:27:00 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:60015/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60015/tests/dromaeo/cssquery-ext.html) 14:27:03 INFO - PROCESS | 27029 | RSS: Main: 164212736 14:27:03 INFO - PROCESS | 27029 | 14:28:49 INFO - PROCESS | 27029 | ************************* 14:28:49 INFO - PROCESS | 27029 | A coding exception was thrown and uncaught in a Task. 14:28:49 INFO - PROCESS | 27029 | 14:28:49 INFO - PROCESS | 27029 | Full message: ReferenceError: fetch is not defined 14:28:49 INFO - PROCESS | 27029 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 14:28:49 INFO - PROCESS | 27029 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 14:28:49 INFO - PROCESS | 27029 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 14:28:49 INFO - PROCESS | 27029 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:28:49 INFO - PROCESS | 27029 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:28:49 INFO - PROCESS | 27029 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:28:49 INFO - PROCESS | 27029 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 14:28:49 INFO - PROCESS | 27029 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:28:49 INFO - PROCESS | 27029 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:28:49 INFO - PROCESS | 27029 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:28:49 INFO - PROCESS | 27029 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 14:28:49 INFO - PROCESS | 27029 | 14:28:49 INFO - PROCESS | 27029 | ************************* 14:30:05 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:60015/tests/dromaeo/cssquery-ext.html (next: http://localhost:60015/tests/dromaeo/cssquery-jquery.html) 14:30:05 INFO - PROCESS | 27029 | RSS: Main: 160980992 14:30:05 INFO - PROCESS | 27029 | 14:33:07 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:60015/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60015/tests/dromaeo/cssquery-mootools.html) 14:33:08 INFO - PROCESS | 27029 | RSS: Main: 165875712 14:33:08 INFO - PROCESS | 27029 | 14:36:10 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:60015/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60015/tests/dromaeo/cssquery-prototype.html) 14:36:10 INFO - PROCESS | 27029 | RSS: Main: 161046528 14:36:10 INFO - PROCESS | 27029 | 14:39:13 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:60015/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60015/tests/dromaeo/cssquery-yui.html) 14:39:14 INFO - PROCESS | 27029 | RSS: Main: 164405248 14:39:14 INFO - PROCESS | 27029 | 14:42:16 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:60015/tests/dromaeo/cssquery-yui.html (next: http://localhost:60015/tests/dromaeo/cssquery-dojo.html) 14:42:16 INFO - PROCESS | 27029 | RSS: Main: 165056512 14:42:16 INFO - PROCESS | 27029 | 14:42:16 INFO - PROCESS | 27029 | __start_tp_report 14:42:16 INFO - PROCESS | 27029 | _x_x_mozilla_page_load 14:42:16 INFO - PROCESS | 27029 | _x_x_mozilla_page_load_details 14:42:16 INFO - PROCESS | 27029 | |i|pagename|runs| 14:42:16 INFO - PROCESS | 27029 | |0;dojo.html;3207.4707673233916;3214.244652506661;3218.7103160715537;3275.688809563092;3297.389982853174;5370.194470829378;5496.285482887224;5562.193481945115;5608.10270356743;5613.354464236609;5378.677279363231;5398.73006349682;5526.834194974157;5527.309086364205;5613.691246981414;4836.17784976554;4858.829940952068;4895.706257624536;4940.283658869462;4964.900701985958;4841.273808928654;4973.204287314031;5050.671706339076;5054.469280725526;5086.92369614456;4820.975895120537;4850.320955066293;4944.233643785219;4963.925541116886;4972.627052971042;4857.78139983698;4896.46138924718;4924.359833221658;4966.180580204262;5048.1670524363435;4915.877103072416;4930.260460930853;4946.554810067111;4969.751512424365;4995.975020124913;5501.202325662756;5520.641158324696;5535.059039963216;5539.14143307788;5550.417206193372;5757.136429535562;5796.13058041293;5889.411058894119;5940.079287710412;5963.940360596425;6042.758289668408;6043.607165534227;6053.213082299273;6055.788047418363;6101.267847858286;5617.494425501724;5631.605787594829;5636.379998200195;5637.379888212294;5645;5896.587238893237;5953.196318496947;5962.493188078975;5991.850203744854;6134;5742.196092547047;5794.0439827428845;5795.536357091422;5812.564057695689;5826.504747096545;5803;5879.764809407576;5880;5903.0260007099205;5912.113183022581;5682.346530149003;5728.742206600713;5832.387599302097;5853.2976042875125;5884.617499862496;5928.229330187048;5932.139839723302;6002;6005.279366476051;6020.247469066367;4573.81704731807;4582.060677561092;4583.381243532081;4593.54064593538;4621.630269578425;4019.9196016079513;4038.63652271297;4087.836486540505;4091.754494730326;4128.855490057834;5522.972385138129;5586.245856809279;5609.074502707089;5665.745041473144;5694.686792226385;6001.339852616209;6043.184170137063;6044.274687037584;6045.3652366501765;6063.605865618721;5593.62956075764;5594.608377413623;5626.493615574536;5645.858853528613;5655.943440565542;4933.28467372229;4961.5286547777905;5059.494050594911;5091.9236211456855;5104.642675012788;6188.381161883775;6229.159063526366;6231.034189700695;6231.283402408691;6233.563650544509;6008.849778755566;6021.157038014594;6033.5173186145885;6047.274327080779;6103.206583144163;5857.26784151981;5873.647581145145;5903.144044113666;5981.551383646157;6225.657588832477;5692.48767610917;5731;5751.971240143773;5752.769889204553;5757.7121143941795;5818.650880947157;5832.387599302182;5832.825015249549;5842.152887831326;5847.853803654943;5693.231413759255;5701.657900525982;5704.914426283692;5710.885782284414;5711.371749107512;5683.431656834284;5687.800926967702;5696.943030569641;5699.316082070178;5724.713764311851;5583.330000399978;5754.367019627922;5776.989026920188;5786.161006653927;5794.536437084938;5788.363280039108;5843.678597676999;5847.649141051551;5852.268466441695;5857.26784151981;5762.827115186551;5771;5778.104393818965;5779.595428319977;5785.797497087582 14:42:16 INFO - PROCESS | 27029 | |1;ext.html;527.6438404077248;548.659830904839;548.9588280878935;553.5986409852857;561.8904313658838;34771.304573908536;42648.14703705928;44165;44180.77909610452;47994;47746.28380574294;48142.75928620361;48225.27662085072;48269;48276.27585586219;8840.115988401141;9136.634534618608;9143.634254629807;9147.405418647766;9148.588313525906;10238.846417303746;10540.736481587945;10554.525046372893;10852.945735271313;10861.83707244392;10596.894031059706;10645;10677.35935843848;10684.358938463716;10692.893071069306;10707.83938240923;10764.784704305948;10769.353838769699;10786.622468213653;10791.99999999996;10324.225683073724;10381.532831022621;10387.532561034772;10397.48012599367;10415.062644361968;41068.38397424011;41093.79453102715;41277;41407;41411.792941035405;3801.961980380216;3831.6359945805384;3849.1147036181555;3853.441251018615;3874.0314921269683;30469.238269043228;30700.2324941876;30854.22864428385;31304.060878173692;32104;4250.596193361625;4429.224885645;4433.822647094113;4464.933026004613;4593.035462552868;344923;348919;349307.50692493;349854;350689;56098.158527622116;56714.7164264176;56729;57085.71457142688;57086.42913570811;60534.39465605376;60861.08708369378;60945;61133.69433152806;61193.38806611966;16987.830121698626;17428.12859357027;17440.86634368762;17449.825501745076;17457.738133928;12015.699607509881;12227;12856.935715321364;12921.353932303347;13019;17542.842288388212;17761.911190444225;18151.364702235358;18336.63326733458;18446.631067378577;6896;7079.964600177069;7224.891626625605;7401.925980740231;7430.368418684364;953.4517652349788;966.917811985975;969.4682401805131;982.6315131825565;993.2302465589082;29984.40031199364;32263.838680806446;32593.511097333558;32765.50851737178;33495;1079.9676009719722;1102.151343465543;1128.785530749155;1131.6209069961656;1145.2899202494507;14976.47582334613;15152.621184470476;15427;15448.227588620748;15764.975276606983;507699;508065;509689;510509;510546;54501.72749136229;54759.726201369536;54965.450345496836;54987.72506137444;55233;1474.2555009720022;1478.8595083467053;1498;1504.638886667192;1509.3208056374676;28448.146555603365;29218;29538;29582.112536623936;30073.849630751705;50165.74917125391;51171.48828511816;51359.486405136966;51422.74288628533;51438.74280628573;502632;503172;504514;505461.9811117938;506729;23991;24123.75876241215;26920.32699182536;27404.451910962067;27445.725542745116;38554;42842.35736464018;43138.35292470553;43145;43498.34752478652;37238;37644.2471150581;38015.239695206496;39473;39908.2018359637;37007.47240557992;37793.62206378011;37864.05339866525;38922.416163757;39101.41347879727;36995.815020924725;37456.25087498289;38217.4267385995;38222.80888595539;38277.23445531129;31721;33573.83213083919;33655;33780.15549611279;33929.49105763465;25483.6177457342;25660.743392566583;25716.614250786628;25739.356516087246;25917 14:42:16 INFO - PROCESS | 27029 | |2;jquery.html;421.33284816217474;424.35074336265484;433.5599366642857;435.17968629134083;445.25197667917905;19720.90139549302;21709.3487195384;21849.016794244257;22471.438214044658;22611;21770;22097.226597069104;22110.33668989929;22235.22176723815;22301.44246393841;5710.828675139732;5946.405359464041;5956.851078723045;5997.310309314441;6000.399960003986;5731.254936858202;5924.763009479637;5944.078667806497;5979.073243647242;5992.700364981755;5728.914066289009;5907.995640741063;5924.289085309769;5927.051671732524;5958.9702051489685;5826.650400975934;5911.231539899829;5912.556558258105;5922.3485416604135;5934.792282270143;5292.047431462335;5323.707196104213;5340.893182136374;5343.973280133613;5347.197920311945;23577.646335304984;23581.528369432515;23726.05095796166;23766;23810.52378952411;2814.957775633367;2839.54567269238;2843.772498200139;2846.9145925622265;2853.2724155340256;15195.848041519554;15966.920165399215;16048;16191.676166476722;16589.17054147288;1965.263026365113;2038.2865996901114;2041.4386043837915;2046.9897650511653;2050.1286953044896;84329.73505397423;88693.11306886913;89279.55360223222;90363;90848.54575727145;11586.88413115858;11683.357415342069;11819.349935753617;11919.344436055926;12063;16710.916445417937;16834.915825420794;16869;16919.746203806953;16958.915205424142;8593.355498337525;8738.38831281817;8871.290296776242;8999.730008099768;9033.683821066232;8334.083250842403;8375.748727538183;8388.37087218461;8525.275351595184;8633.611487483078;7417.21589574732;7518.812029699301;7555.508891922007;7679.539227646359;7772.989511363599;2022.2699355869458;2051.210284040625;2059.4954236211925;2142.6036183306137;2164.1235299703644;931.5668214280392;946.2288235088381;946.4983558713893;950.064186776025;951.4671783801093;19610.215591376185;21506.83294155163;21588.56822863534;21707.13171473155;21725.565488690452;938.7653086728318;944.329526036508;945.229637845154;970.3644113105927;977.8728765260613;11994.940025299818;12181.573644922562;12280.263184208976;12304.569340073054;12319;639654;649578;653285;657086;660650;95814.52092739491;96061.4332423433;96331.51834240924;96953.5152324234;98527.50736246273;1096.9725756855983;1109.0905457524914;1113.6993011886746;1118.8713297970676;1121.198343184627;18416.35542755997;18474.353397631017;18775.812241877407;18779.154938028096;19031.42905712831;42977.14045719006;43010.35484467673;43213.567864320954;43681.907952301444;44177.77911110424;56999.71500142639;57417.42582574121;57842.4215757837;65120.348796513324;66556;9179.219766319937;9238.95380523093;9452.10205030521;9461.101195386427;9578.233741300819;13873.4450621974;14365.281735912953;14387.712245755236;14424.350904209126;14737;11657.650270491898;12268.570600028956;12519.061070419937;12640.494380224687;12883.677908052;12270.32513211782;12771.680707982003;12805.295708736108;13208.405621747237;13225.669358266121;12692.428840702007;12837.229766214057;12900.870991290343;12913.548025819051;12939.288339141438;9274.489903055126;9380.108889655472;9493.382930109521;9530.809383812146;9659.71020869375;11297.943510282395;12536.874631253571;12582.811257830957;12833.486660533474;13053.28206948627 14:42:16 INFO - PROCESS | 27029 | |3;mootools.html;1461.6418977350552;1465.772805215192;1480.748272793625;1483.9925800370997;1493.4847477620222;7341.5962122083265;7639.579823109741;7806.102298235704;8229.053658829236;8263.545504997222;7856;8135.7152499662525;8172.59137043147;8342.74971750847;8357.707480238192;2283.063943783049;2306;2310.4570425949887;2320.721513418392;2325.534893021394;2325.872077035771;2353.988230058856;2367.3371455992265;2370.182287110944;2378.3935096550354;2338.0530884991604;2356.646503024543;2369.5024044950583;2374.4301367671806;2376.6791483149727;2170.9891450542805;2202.2512345802425;2257.7290725112925;2282.4978504728933;2285.06312411912;2268.4442311633757;2268.965965510519;2276.3398614401804;2287.2795069553204;2292.1289909834154;8180.713675021346;8219.136990616018;8234.300084492825;8253.174682531699;8358.791030224233;4982.90034199314;5084.923726144111;5086.389633243997;5098.643094983353;5101.260317254015;3028.212664707192;3132.9686703132907;3292.8024318540965;3293.7859039162377;3299.3236386540702;1284.7688064517745;1307.941142648583;1320.7094439223451;1321.8876395506393;1335.5859683498147;11004.229703920728;11100.500477478532;11122.721931951684;11155.330680159217;11217.831732524019;4472.105578884236;4554.521775213621;4645.674802763774;4711.363965864564;4770.713757174581;9597.664081757104;9649.903500965042;9689.321747477608;9703.320767546204;9726.70819875405;5194.32473778414;5225.137852254412;5228.215767634885;5239.973800130975;5255.5795536357;4171.290880550314;4216.8313267469575;4796.088743138793;4813.181759100961;4840.419149702058;3859.845606175778;3911.9217615647526;3913.2173565287057;3992.3612222044335;4019.598040195957;1284.800855867342;1287.291989405823;1296.695276609996;1301.7852054410916;1311.3770958794687;994.174834887042;999.3703966501204;1007.7329507680471;1020.8519764634235;1022.9795404091876;5544.473275038865;5563.888722225533;5807.912881306784;5911.379305172981;6000.969995150083;1066.36018388966;1071.7159952612565;1077.9946100269606;1081.9242653014371;1100.6037826382496;3939.7242193046213;3944.1914407546383;3979.7811120388656;4014.437978682987;4015.5181378234215;9730.270229732656;9937.503124843874;10011.44937028456;10050.648227312155;10107.241956853119;9804.166645835041;9860.950695246622;9866.260030497742;9951.353162044445;9961.153301969269;7443.516171448839;7751.1861254568585;7799.45403821727;7871;7927.5243485391065;5494.697791621499;5608.4111168326735;5699.088145896637;5749.942500574941;5779.422057794187;8882.245009174292;8952.865707014269;9014.233790127913;9045;9137.954310228406;9065.818683626423;9095.363324567217;9102.499362535124;9154.771130721785;9231.907680923105;6994.370506654425;7240.203577606564;7301.853962920818;7386.926130738624;7401.185869554452;8019.6391162398995;8056.355491560544;8071.273585377344;8099.392545559224;8110.878336825071;7181;7201.4238860889955;7375.8156046099275;7485.4385921055045;7515.549067055994;6889.345512176335;6975.162980442379;7004.929950700632;7024.473164512579;7063.540869843444;6397.072424498515;6532.444742196776;6538.640374779433;6546.8363290918105;6561.639109848813;4993.27597498368;5067.670601410897;5098.643094983316;5191.428942816212;5214.843554693365;4947.554720075211;5029.170186919264;5109.514596113363;5118.206677964921;5128.717920514258 14:42:16 INFO - PROCESS | 27029 | |4;prototype.html;397.53488418550296;407.7512717242482;412.8947118484786;413.0520455554504;418.54169684195807;5318.25544423781;5470.152126420411;5507.36665283492;5539.501444869961;5576.302962129734;5372.91940620891;5375.193720941861;5378.865528361793;5403.486668766461;5414.810481633143;4140.31684772013;4164.895877603069;4185.372194170884;4196.685248606352;4210.936835947448;3998.6001399860074;4168.5623009584015;4204.348326009458;4221.577842215769;4265.146970605876;4131.876043718693;4138.496209793077;4142.233686767958;4147.668186545069;4163.39630753542;4140.648044916185;4160.687948403852;4171.207470580595;4178.958210417887;4203.831846726127;3725.8137093145233;3739.906502337436;3755.962440375589;3761.1725420407465;3762.811859407019;5205.609579281569;5244.449332820037;5288;5292.973535132338;5307.787688492455;4860.343853579757;4874.46380898101;4879.268109783526;4883.413990321149;4896.290037944478;5500.944990550123;5707.429257074259;5743.822516384173;5754.367019627837;5798.681072541009;4094.447249621293;4109.137081212949;4111.9177616447805;4116;4121.5466298707115;5886.7939622113445;5887.470127688529;5951.375105613892;5969.403059694039;5990.341062483123;4189.476315460567;4204.453421055305;4206.422591528177;4222.733180045974;4256.7658778766845;4059.1475790083823;4239.830406783756;4272.829086836554;4278.7432754034235;4308.138372325548;4854.368932038883;4855.9074208303555;4858.902821943541;4872.561469467694;4905.920697446556;5736.42635736423;5806.21616081832;5833.7083145842535;5857.179994800731;5858.326292476335;1419.7718973088204;1424.3803945283628;1434.3258668425824;1437.4322142753554;1438.2377340009812;961.5480724059681;990.7622170678985;995.8307087795092;997.7705127820642;1013.640157744005;5271.947280527145;5331.386890507563;5333.386660534088;5339.652922560022;5349.866253343697;5550;5610;5663.405342439067;5663.858403539862;5679.586175875236;5189.662671926313;5232.529072383428;5379.300690910235;5420.593455490854;5441.8572099859475;2976.9851150744107;3005.9549106763416;3017.5171972484736;3043.8630261638277;3050.2679356954172;5934.9406505934385;5949.851253718605;5950.523958083343;5957.463828255478;5965.791197308074;5700.263873340737;6018.548608854353;6049.879002419927;6056.515478761777;6092.878142437126;6133.53998450127;6141.57009009374;6145.0782382642965;6156.6921653917125;6187.721552530147;5592.909382670503;5815.738291776965;5858.543459358999;5902.675352855634;5913.408659134224;5801.883962320646;5803.767849285981;5829.679367634821;5842.83143371319;5908.379620139824;5836;6076.665783381956;6084.0757711276865;6145.631262124287;6151.323354431099;4125.91748165041;4163.8959026024595;4224.218519573888;4235.957640423557;4243.68172387066;5872.442117998783;5896.054302080217;5897;5897.351291358033;5908.4593624740055;5745.798897038583;5751.849630073918;5753.971230143822;5754.625949313281;5757.309122905278;5620.85947851307;5756.165356023437;5790.305163380422;5793.15999180125;5836.124581312667;5662.518685911744;5703.714814259353;5744.597878148489;5761.48146666802;5772.855678608068;5455.481729235717;5773.393793651774;5800.186909349047;5814.854628634318;5823.475887170175;5647.29408823897;5649.209110724584;5664.660120392789;5668.433156684464;5671.546276297804 14:42:16 INFO - PROCESS | 27029 | |5;yui.html;744.8696478116332;745.8210029592899;785.4462603864276;857.0211332494476;889.3952112563456;17109.315627374905;17947.730784038235;18014.72977905329;18016.099195040228;18073.638527229446;17630;17725.82274177258;17744.645107097884;17745.911270443663;17943.64112717748;735.1325435985535;740.7555506682809;758.4008633179809;760.7337431898819;766;765.6898955922833;772.8995230620039;773.0877564473918;773.7253275087347;773.9767806965772;800.5036877136183;802.6027116577302;802.6468353924283;803.1847674610275;803.8794180872858;791.2206476620581;793.0404210904783;793.7261644732558;796.2515235678444;798.1778767869104;587.3744462147799;587.870668452944;588.2323567744093;588.3410580150216;588.3675049321953;16157.596060098474;16537.421190258403;16577.751333730004;16635.334586616522;16761.66476670472;14817.555473335817;14989.250537473192;15445;15699.843001569952;15731.292091855894;12180.878191218064;12296.508139674403;12323.753524929542;12346.629601111981;12430.316332601704;3732.682721968636;3755.6432138946757;3793.943090853639;3799.886003419902;3823.9044023899346;88819.55590222072;89832.55083724605;90208.5489572548;90812;91655.54172229163;12106.394680266128;12183.512659493521;12186.878131218751;12189.573364932185;12253.877461225451;24098.51802963966;24295.27114186577;24306;24325.635115473284;24411.511769764504;7774.1837107104075;7794.532328060334;7895.802604934923;8074.071481779553;8150.959245203855;4227.175700738327;4259.936100958488;4271.658267338606;4343.1530851484285;4351.303791393425;3613.457981302773;3649.6496296369983;3687.7602955808325;3704.3517384457614;3717.4795528626014;676.0298970976664;677.9965650836789;680.0649107477219;688.4629988608793;691.9757808476679;785.7917651822272;786.1077676836832;797.6928882380325;811.6550466051905;829.9751007469786;10659.360438373722;10764.643301317186;10903;10912.563497460013;11014.44927753609;648.7988723495731;651.26407159909;667.0860920538893;672.6872004517923;672.7712577723597;5036.093503169392;5230.660007099603;5265.921011184835;5273.973630131824;5284.841454756286;88105;88900;89388;89995.55002225078;91782;63066.36933630697;63243;64267;64279;79632.60183699045;62919.37080629227;63992;64648;65051.67474162599;65691;10483.475826208507;10942.343459392461;11040.171987100839;11182.217244793112;11218.158638102339;43640.781796090814;43798.56201437945;45020;45518.544814552755;45663.31505027361;43531;44112.33831492466;48721.51278487311;54632.45367546273;55128.72435637796;13120;13232.470701172231;13396.732065358834;13731.176129432266;13796.310184490534;14453.49412770548;14575.489857854924;14609.780853287422;14694.191819450032;15545.756339492587;13478.730425391634;13579.59261222165;13630.522931697344;14264.358103885557;14268.857311426753;13832.239226842621;13931.512397066459;14815.92592037033;15242.237888105328;16022.519324420286;14107.647308817363;14487.92756036213;14550.345234464687;14565;14644.560663180122;11286.66140015801;11786.941065294619;11965.76068478608;12300;12602;10855.945720271347;12255.69360765988;12272.38638068111;12299.508019679113;12681.175723577939 14:42:16 INFO - PROCESS | 27029 | __end_tp_report 14:42:16 INFO - PROCESS | 27029 | __start_cc_report 14:42:16 INFO - PROCESS | 27029 | _x_x_mozilla_cycle_collect,316 14:42:16 INFO - PROCESS | 27029 | __end_cc_report 14:42:16 INFO - PROCESS | 27029 | __startTimestamp1484001736963__endTimestamp 14:42:16 INFO - PROCESS | 27029 | 14:42:16 INFO - PROCESS | 27029 | ------- Summary: start ------- 14:42:16 INFO - PROCESS | 27029 | Number of tests: 6 14:42:16 INFO - PROCESS | 27029 | 14:42:16 INFO - PROCESS | 27029 | [#0] dojo.html Cycles:165 Average:5485.45 Median:5699.32 stddev:628.24 (11.0%) stddev-sans-first:604.21 14:42:16 INFO - PROCESS | 27029 | Values: 3207.5 3214.2 3218.7 3275.7 3297.4 5370.2 5496.3 5562.2 5608.1 5613.4 5378.7 5398.7 5526.8 5527.3 5613.7 4836.2 4858.8 4895.7 4940.3 4964.9 4841.3 4973.2 5050.7 5054.5 5086.9 4821.0 4850.3 4944.2 4963.9 4972.6 4857.8 4896.5 4924.4 4966.2 5048.2 4915.9 4930.3 4946.6 4969.8 4996.0 5501.2 5520.6 5535.1 5539.1 5550.4 5757.1 5796.1 5889.4 5940.1 5963.9 6042.8 6043.6 6053.2 6055.8 6101.3 5617.5 5631.6 5636.4 5637.4 5645.0 5896.6 5953.2 5962.5 5991.9 6134.0 5742.2 5794.0 5795.5 5812.6 5826.5 5803.0 5879.8 5880.0 5903.0 5912.1 5682.3 5728.7 5832.4 5853.3 5884.6 5928.2 5932.1 6002.0 6005.3 6020.2 4573.8 4582.1 4583.4 4593.5 4621.6 4019.9 4038.6 4087.8 4091.8 4128.9 5523.0 5586.2 5609.1 5665.7 5694.7 6001.3 6043.2 6044.3 6045.4 6063.6 5593.6 5594.6 5626.5 5645.9 5655.9 4933.3 4961.5 5059.5 5091.9 5104.6 6188.4 6229.2 6231.0 6231.3 6233.6 6008.8 6021.2 6033.5 6047.3 6103.2 5857.3 5873.6 5903.1 5981.6 6225.7 5692.5 5731.0 5752.0 5752.8 5757.7 5818.7 5832.4 5832.8 5842.2 5847.9 5693.2 5701.7 5704.9 5710.9 5711.4 5683.4 5687.8 5696.9 5699.3 5724.7 5583.3 5754.4 5777.0 5786.2 5794.5 5788.4 5843.7 5847.6 5852.3 5857.3 5762.8 5771.0 5778.1 5779.6 5785.8 14:42:16 INFO - PROCESS | 27029 | 14:42:16 INFO - PROCESS | 27029 | [#1] ext.html Cycles:180 Average:60755.12 Median:37718.93 stddev:122154.28 (323.9%) stddev-sans-first:122413.26 14:42:16 INFO - PROCESS | 27029 | Values: 527.6 548.7 549.0 553.6 561.9 34771.3 42648.1 44165.0 44180.8 47994.0 47746.3 48142.8 48225.3 48269.0 48276.3 8840.1 9136.6 9143.6 9147.4 9148.6 10238.8 10540.7 10554.5 10852.9 10861.8 10596.9 10645.0 10677.4 10684.4 10692.9 10707.8 10764.8 10769.4 10786.6 10792.0 10324.2 10381.5 10387.5 10397.5 10415.1 41068.4 41093.8 41277.0 41407.0 41411.8 3802.0 3831.6 3849.1 3853.4 3874.0 30469.2 30700.2 30854.2 31304.1 32104.0 4250.6 4429.2 4433.8 4464.9 4593.0 344923.0 348919.0 349307.5 349854.0 350689.0 56098.2 56714.7 56729.0 57085.7 57086.4 60534.4 60861.1 60945.0 61133.7 61193.4 16987.8 17428.1 17440.9 17449.8 17457.7 12015.7 12227.0 12856.9 12921.4 13019.0 17542.8 17761.9 18151.4 18336.6 18446.6 6896.0 7080.0 7224.9 7401.9 7430.4 953.5 966.9 969.5 982.6 993.2 29984.4 32263.8 32593.5 32765.5 33495.0 1080.0 1102.2 1128.8 1131.6 1145.3 14976.5 15152.6 15427.0 15448.2 15765.0 507699.0 508065.0 509689.0 510509.0 510546.0 54501.7 54759.7 54965.5 54987.7 55233.0 1474.3 1478.9 1498.0 1504.6 1509.3 28448.1 29218.0 29538.0 29582.1 30073.8 50165.7 51171.5 51359.5 51422.7 51438.7 502632.0 503172.0 504514.0 505462.0 506729.0 23991.0 24123.8 26920.3 27404.5 27445.7 38554.0 42842.4 43138.4 43145.0 43498.3 37238.0 37644.2 38015.2 39473.0 39908.2 37007.5 37793.6 37864.1 38922.4 39101.4 36995.8 37456.3 38217.4 38222.8 38277.2 31721.0 33573.8 33655.0 33780.2 33929.5 25483.6 25660.7 25716.6 25739.4 25917.0 14:42:16 INFO - PROCESS | 27029 | 14:42:16 INFO - PROCESS | 27029 | [#2] jquery.html Cycles:180 Average:34833.02 Median:422.84 stddev:106878.21 (25276.2%) stddev-sans-first:107146.80 14:42:16 INFO - PROCESS | 27029 | Values: 421.3 424.4 433.6 435.2 445.3 19720.9 21709.3 21849.0 22471.4 22611.0 21770.0 22097.2 22110.3 22235.2 22301.4 5710.8 5946.4 5956.9 5997.3 6000.4 5731.3 5924.8 5944.1 5979.1 5992.7 5728.9 5908.0 5924.3 5927.1 5959.0 5826.7 5911.2 5912.6 5922.3 5934.8 5292.0 5323.7 5340.9 5344.0 5347.2 23577.6 23581.5 23726.1 23766.0 23810.5 2815.0 2839.5 2843.8 2846.9 2853.3 15195.8 15966.9 16048.0 16191.7 16589.2 1965.3 2038.3 2041.4 2047.0 2050.1 84329.7 88693.1 89279.6 90363.0 90848.5 11586.9 11683.4 11819.3 11919.3 12063.0 16710.9 16834.9 16869.0 16919.7 16958.9 8593.4 8738.4 8871.3 8999.7 9033.7 8334.1 8375.7 8388.4 8525.3 8633.6 7417.2 7518.8 7555.5 7679.5 7773.0 2022.3 2051.2 2059.5 2142.6 2164.1 931.6 946.2 946.5 950.1 951.5 19610.2 21506.8 21588.6 21707.1 21725.6 938.8 944.3 945.2 970.4 977.9 11994.9 12181.6 12280.3 12304.6 12319.0 639654.0 649578.0 653285.0 657086.0 660650.0 95814.5 96061.4 96331.5 96953.5 98527.5 1097.0 1109.1 1113.7 1118.9 1121.2 18416.4 18474.4 18775.8 18779.2 19031.4 42977.1 43010.4 43213.6 43681.9 44177.8 56999.7 57417.4 57842.4 65120.3 66556.0 9179.2 9239.0 9452.1 9461.1 9578.2 13873.4 14365.3 14387.7 14424.4 14737.0 11657.7 12268.6 12519.1 12640.5 12883.7 12270.3 12771.7 12805.3 13208.4 13225.7 12692.4 12837.2 12900.9 12913.5 12939.3 9274.5 9380.1 9493.4 9530.8 9659.7 11297.9 12536.9 12582.8 12833.5 13053.3 14:42:16 INFO - PROCESS | 27029 | 14:42:16 INFO - PROCESS | 27029 | [#3] mootools.html Cycles:180 Average:5471.71 Median:5105.39 stddev:2943.53 (57.7%) stddev-sans-first:2936.36 14:42:16 INFO - PROCESS | 27029 | Values: 1461.6 1465.8 1480.7 1484.0 1493.5 7341.6 7639.6 7806.1 8229.1 8263.5 7856.0 8135.7 8172.6 8342.7 8357.7 2283.1 2306.0 2310.5 2320.7 2325.5 2325.9 2354.0 2367.3 2370.2 2378.4 2338.1 2356.6 2369.5 2374.4 2376.7 2171.0 2202.3 2257.7 2282.5 2285.1 2268.4 2269.0 2276.3 2287.3 2292.1 8180.7 8219.1 8234.3 8253.2 8358.8 4982.9 5084.9 5086.4 5098.6 5101.3 3028.2 3133.0 3292.8 3293.8 3299.3 1284.8 1307.9 1320.7 1321.9 1335.6 11004.2 11100.5 11122.7 11155.3 11217.8 4472.1 4554.5 4645.7 4711.4 4770.7 9597.7 9649.9 9689.3 9703.3 9726.7 5194.3 5225.1 5228.2 5240.0 5255.6 4171.3 4216.8 4796.1 4813.2 4840.4 3859.8 3911.9 3913.2 3992.4 4019.6 1284.8 1287.3 1296.7 1301.8 1311.4 994.2 999.4 1007.7 1020.9 1023.0 5544.5 5563.9 5807.9 5911.4 6001.0 1066.4 1071.7 1078.0 1081.9 1100.6 3939.7 3944.2 3979.8 4014.4 4015.5 9730.3 9937.5 10011.4 10050.6 10107.2 9804.2 9861.0 9866.3 9951.4 9961.2 7443.5 7751.2 7799.5 7871.0 7927.5 5494.7 5608.4 5699.1 5749.9 5779.4 8882.2 8952.9 9014.2 9045.0 9138.0 9065.8 9095.4 9102.5 9154.8 9231.9 6994.4 7240.2 7301.9 7386.9 7401.2 8019.6 8056.4 8071.3 8099.4 8110.9 7181.0 7201.4 7375.8 7485.4 7515.5 6889.3 6975.2 7004.9 7024.5 7063.5 6397.1 6532.4 6538.6 6546.8 6561.6 4993.3 5067.7 5098.6 5191.4 5214.8 4947.6 5029.2 5109.5 5118.2 5128.7 14:42:16 INFO - PROCESS | 27029 | 14:42:16 INFO - PROCESS | 27029 | [#4] prototype.html Cycles:180 Average:4805.28 Median:5431.23 stddev:1416.51 (26.1%) stddev-sans-first:1381.31 14:42:16 INFO - PROCESS | 27029 | Values: 397.5 407.8 412.9 413.1 418.5 5318.3 5470.2 5507.4 5539.5 5576.3 5372.9 5375.2 5378.9 5403.5 5414.8 4140.3 4164.9 4185.4 4196.7 4210.9 3998.6 4168.6 4204.3 4221.6 4265.1 4131.9 4138.5 4142.2 4147.7 4163.4 4140.6 4160.7 4171.2 4179.0 4203.8 3725.8 3739.9 3756.0 3761.2 3762.8 5205.6 5244.4 5288.0 5293.0 5307.8 4860.3 4874.5 4879.3 4883.4 4896.3 5500.9 5707.4 5743.8 5754.4 5798.7 4094.4 4109.1 4111.9 4116.0 4121.5 5886.8 5887.5 5951.4 5969.4 5990.3 4189.5 4204.5 4206.4 4222.7 4256.8 4059.1 4239.8 4272.8 4278.7 4308.1 4854.4 4855.9 4858.9 4872.6 4905.9 5736.4 5806.2 5833.7 5857.2 5858.3 1419.8 1424.4 1434.3 1437.4 1438.2 961.5 990.8 995.8 997.8 1013.6 5271.9 5331.4 5333.4 5339.7 5349.9 5550.0 5610.0 5663.4 5663.9 5679.6 5189.7 5232.5 5379.3 5420.6 5441.9 2977.0 3006.0 3017.5 3043.9 3050.3 5934.9 5949.9 5950.5 5957.5 5965.8 5700.3 6018.5 6049.9 6056.5 6092.9 6133.5 6141.6 6145.1 6156.7 6187.7 5592.9 5815.7 5858.5 5902.7 5913.4 5801.9 5803.8 5829.7 5842.8 5908.4 5836.0 6076.7 6084.1 6145.6 6151.3 4125.9 4163.9 4224.2 4236.0 4243.7 5872.4 5896.1 5897.0 5897.4 5908.5 5745.8 5751.8 5754.0 5754.6 5757.3 5620.9 5756.2 5790.3 5793.2 5836.1 5662.5 5703.7 5744.6 5761.5 5772.9 5455.5 5773.4 5800.2 5814.9 5823.5 5647.3 5649.2 5664.7 5668.4 5671.5 14:42:16 INFO - PROCESS | 27029 | 14:42:16 INFO - PROCESS | 27029 | [#5] yui.html Cycles:180 Average:18617.33 Median:4243.56 stddev:23958.57 (564.6%) stddev-sans-first:23988.19 14:42:16 INFO - PROCESS | 27029 | Values: 744.9 745.8 785.4 857.0 889.4 17109.3 17947.7 18014.7 18016.1 18073.6 17630.0 17725.8 17744.6 17745.9 17943.6 735.1 740.8 758.4 760.7 766.0 765.7 772.9 773.1 773.7 774.0 800.5 802.6 802.6 803.2 803.9 791.2 793.0 793.7 796.3 798.2 587.4 587.9 588.2 588.3 588.4 16157.6 16537.4 16577.8 16635.3 16761.7 14817.6 14989.3 15445.0 15699.8 15731.3 12180.9 12296.5 12323.8 12346.6 12430.3 3732.7 3755.6 3793.9 3799.9 3823.9 88819.6 89832.6 90208.5 90812.0 91655.5 12106.4 12183.5 12186.9 12189.6 12253.9 24098.5 24295.3 24306.0 24325.6 24411.5 7774.2 7794.5 7895.8 8074.1 8151.0 4227.2 4259.9 4271.7 4343.2 4351.3 3613.5 3649.6 3687.8 3704.4 3717.5 676.0 678.0 680.1 688.5 692.0 785.8 786.1 797.7 811.7 830.0 10659.4 10764.6 10903.0 10912.6 11014.4 648.8 651.3 667.1 672.7 672.8 5036.1 5230.7 5265.9 5274.0 5284.8 88105.0 88900.0 89388.0 89995.6 91782.0 63066.4 63243.0 64267.0 64279.0 79632.6 62919.4 63992.0 64648.0 65051.7 65691.0 10483.5 10942.3 11040.2 11182.2 11218.2 43640.8 43798.6 45020.0 45518.5 45663.3 43531.0 44112.3 48721.5 54632.5 55128.7 13120.0 13232.5 13396.7 13731.2 13796.3 14453.5 14575.5 14609.8 14694.2 15545.8 13478.7 13579.6 13630.5 14264.4 14268.9 13832.2 13931.5 14815.9 15242.2 16022.5 14107.6 14487.9 14550.3 14565.0 14644.6 11286.7 11786.9 11965.8 12300.0 12602.0 10855.9 12255.7 12272.4 12299.5 12681.2 14:42:16 INFO - PROCESS | 27029 | -------- Summary: end -------- 14:42:16 INFO - PROCESS | 27029 | 14:42:17 INFO - TEST-INFO | 27029: exit 0 14:42:17 INFO - TEST-OK | dromaeo_css | took 1114698ms 14:42:17 INFO - TEST-START | kraken 14:42:17 INFO - operating with platform_type : linux_ 14:42:17 INFO - Initialising browser for kraken test... 14:42:17 INFO - TEST-INFO | started process 27380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAs0NFT/profile http://localhost:60015/getInfo.html) 14:42:18 INFO - PROCESS | 27380 | 1484001738246 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:4905 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3760 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2793 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 14:42:21 INFO - PROCESS | 27380 | __metrics Screen width/height:1600/1200 14:42:21 INFO - PROCESS | 27380 | colorDepth:24 14:42:21 INFO - PROCESS | 27380 | Browser inner width/height: 1024/697 14:42:21 INFO - PROCESS | 27380 | __metrics 14:42:22 ERROR - PROCESS | 27380 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 14:42:23 INFO - TEST-INFO | 27380: exit 0 14:42:23 INFO - Browser initialized. 14:42:23 INFO - Running cycle 1/1 for kraken test... 14:42:23 INFO - TEST-INFO | started process 27501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAs0NFT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:35 INFO - PROCESS | 27501 | RSS: Main: 154968064 14:42:35 INFO - PROCESS | 27501 | 14:42:37 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60015/tests/kraken/driver.html?testName=audio-beat-detection) 14:42:38 INFO - PROCESS | 27501 | RSS: Main: 162025472 14:42:38 INFO - PROCESS | 27501 | 14:42:41 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60015/tests/kraken/driver.html?testName=audio-dft) 14:42:41 INFO - PROCESS | 27501 | RSS: Main: 160890880 14:42:41 INFO - PROCESS | 27501 | 14:42:44 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60015/tests/kraken/driver.html?testName=audio-fft) 14:42:45 INFO - PROCESS | 27501 | RSS: Main: 157257728 14:42:45 INFO - PROCESS | 27501 | 14:42:47 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60015/tests/kraken/driver.html?testName=audio-oscillator) 14:42:48 INFO - PROCESS | 27501 | RSS: Main: 158011392 14:42:48 INFO - PROCESS | 27501 | 14:42:50 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60015/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:42:50 INFO - PROCESS | 27501 | RSS: Main: 157999104 14:42:50 INFO - PROCESS | 27501 | 14:42:54 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60015/tests/kraken/driver.html?testName=imaging-darkroom) 14:42:54 INFO - PROCESS | 27501 | RSS: Main: 162246656 14:42:54 INFO - PROCESS | 27501 | 14:42:58 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60015/tests/kraken/driver.html?testName=imaging-desaturate) 14:42:58 INFO - PROCESS | 27501 | RSS: Main: 160448512 14:42:58 INFO - PROCESS | 27501 | 14:43:01 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60015/tests/kraken/driver.html?testName=json-parse-financial) 14:43:02 INFO - PROCESS | 27501 | RSS: Main: 160296960 14:43:02 INFO - PROCESS | 27501 | 14:43:03 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60015/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:43:04 INFO - PROCESS | 27501 | RSS: Main: 160645120 14:43:04 INFO - PROCESS | 27501 | 14:43:06 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60015/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:43:07 INFO - PROCESS | 27501 | RSS: Main: 160747520 14:43:07 INFO - PROCESS | 27501 | 14:43:09 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60015/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:43:09 INFO - PROCESS | 27501 | RSS: Main: 161382400 14:43:09 INFO - PROCESS | 27501 | 14:43:12 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:43:13 INFO - PROCESS | 27501 | RSS: Main: 160866304 14:43:13 INFO - PROCESS | 27501 | 14:43:16 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:43:16 INFO - PROCESS | 27501 | RSS: Main: 161230848 14:43:16 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | Cycle 1(1): loaded http://localhost:60015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60015/tests/kraken/driver.html?testName=ai-astar) 14:43:18 INFO - PROCESS | 27501 | RSS: Main: 162443264 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | __start_tp_report 14:43:18 INFO - PROCESS | 27501 | _x_x_mozilla_page_load 14:43:18 INFO - PROCESS | 27501 | _x_x_mozilla_page_load_details 14:43:18 INFO - PROCESS | 27501 | |i|pagename|runs| 14:43:18 INFO - PROCESS | 27501 | |0;ai-astar;103;112;112;111;111;112;110;113;116;115 14:43:18 INFO - PROCESS | 27501 | |1;audio-beat-detection;140;118;118;170;119;120;117;119;141;124 14:43:18 INFO - PROCESS | 27501 | |2;audio-dft;163;163;164;163;163;164;167;166;164;162 14:43:18 INFO - PROCESS | 27501 | |3;audio-fft;76;76;76;102;78;79;78;77;102;77 14:43:18 INFO - PROCESS | 27501 | |4;audio-oscillator;85;84;114;83;84;84;98;84;85;104 14:43:18 INFO - PROCESS | 27501 | |5;imaging-gaussian-blur;119;119;118;118;117;118;118;118;118;122 14:43:18 INFO - PROCESS | 27501 | |6;imaging-darkroom;148;148;149;148;148;148;147;147;148;147 14:43:18 INFO - PROCESS | 27501 | |7;imaging-desaturate;98;103;97;96;97;97;97;96;97;96 14:43:18 INFO - PROCESS | 27501 | |8;json-parse-financial;65;56;58;58;58;57;63;57;56;58 14:43:18 INFO - PROCESS | 27501 | |9;json-stringify-tinderbox;67;72;67;67;68;72;69;68;70;68 14:43:18 INFO - PROCESS | 27501 | |10;stanford-crypto-aes;85;85;82;82;83;82;82;82;83;81 14:43:18 INFO - PROCESS | 27501 | |11;stanford-crypto-ccm;138;133;130;140;137;127;127;126;168;142 14:43:18 INFO - PROCESS | 27501 | |12;stanford-crypto-pbkdf2;171;174;168;171;173;171;167;188;169;167 14:43:18 INFO - PROCESS | 27501 | |13;stanford-crypto-sha256-iterative;64;64;68;63;64;63;63;63;64;65 14:43:18 INFO - PROCESS | 27501 | __end_tp_report 14:43:18 INFO - PROCESS | 27501 | __start_cc_report 14:43:18 INFO - PROCESS | 27501 | _x_x_mozilla_cycle_collect,738 14:43:18 INFO - PROCESS | 27501 | __end_cc_report 14:43:18 INFO - PROCESS | 27501 | __startTimestamp1484001798593__endTimestamp 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | ------- Summary: start ------- 14:43:18 INFO - PROCESS | 27501 | Number of tests: 14 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:1.94 14:43:18 INFO - PROCESS | 27501 | Values: 103.0 112.0 112.0 111.0 111.0 112.0 110.0 113.0 116.0 115.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:122.00 stddev:17.12 (14.0%) stddev-sans-first:17.65 14:43:18 INFO - PROCESS | 27501 | Values: 140.0 118.0 118.0 170.0 119.0 120.0 117.0 119.0 141.0 124.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.52 (0.9%) stddev-sans-first:1.58 14:43:18 INFO - PROCESS | 27501 | Values: 163.0 163.0 164.0 163.0 163.0 164.0 167.0 166.0 164.0 162.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:10.54 (13.7%) stddev-sans-first:10.94 14:43:18 INFO - PROCESS | 27501 | Values: 76.0 76.0 76.0 102.0 78.0 79.0 78.0 77.0 102.0 77.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:84.00 stddev:10.94 (13.0%) stddev-sans-first:11.42 14:43:18 INFO - PROCESS | 27501 | Values: 85.0 84.0 114.0 83.0 84.0 84.0 98.0 84.0 85.0 104.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:1.35 (1.1%) stddev-sans-first:1.42 14:43:18 INFO - PROCESS | 27501 | Values: 119.0 119.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 122.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:43:18 INFO - PROCESS | 27501 | Values: 148.0 148.0 149.0 148.0 148.0 148.0 147.0 147.0 148.0 147.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:97.00 stddev:2.07 (2.1%) stddev-sans-first:2.18 14:43:18 INFO - PROCESS | 27501 | Values: 98.0 103.0 97.0 96.0 97.0 97.0 97.0 96.0 97.0 96.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:2.99 (5.2%) stddev-sans-first:2.09 14:43:18 INFO - PROCESS | 27501 | Values: 65.0 56.0 58.0 58.0 58.0 57.0 63.0 57.0 56.0 58.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:68.50 stddev:1.93 (2.8%) stddev-sans-first:1.94 14:43:18 INFO - PROCESS | 27501 | Values: 67.0 72.0 67.0 67.0 68.0 72.0 69.0 68.0 70.0 68.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:1.34 (1.6%) stddev-sans-first:1.13 14:43:18 INFO - PROCESS | 27501 | Values: 85.0 85.0 82.0 82.0 83.0 82.0 82.0 82.0 83.0 81.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:137.50 stddev:12.39 (9.0%) stddev-sans-first:13.13 14:43:18 INFO - PROCESS | 27501 | Values: 138.0 133.0 130.0 140.0 137.0 127.0 127.0 126.0 168.0 142.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:171.00 stddev:6.14 (3.6%) stddev-sans-first:6.50 14:43:18 INFO - PROCESS | 27501 | Values: 171.0 174.0 168.0 171.0 173.0 171.0 167.0 188.0 169.0 167.0 14:43:18 INFO - PROCESS | 27501 | 14:43:18 INFO - PROCESS | 27501 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.52 (2.4%) stddev-sans-first:1.62 14:43:18 INFO - PROCESS | 27501 | Values: 64.0 64.0 68.0 63.0 64.0 63.0 63.0 63.0 64.0 65.0 14:43:18 INFO - PROCESS | 27501 | -------- Summary: end -------- 14:43:18 INFO - PROCESS | 27501 | 14:43:19 INFO - TEST-INFO | 27501: exit 0 14:43:19 INFO - TEST-OK | kraken | took 61871ms 14:43:19 INFO - SUITE-END | took 1176s 14:43:19 INFO - Completed test suite (00:19:36) 14:43:19 INFO - javascript benchmark 14:43:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7399.560830248244, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3207.4707673233916, 3214.244652506661, 3218.7103160715537, 3275.688809563092, 3297.389982853174, 5370.194470829378, 5496.285482887224, 5562.193481945115, 5608.10270356743, 5613.354464236609, 5378.677279363231, 5398.73006349682, 5526.834194974157, 5527.309086364205, 5613.691246981414, 4836.17784976554, 4858.829940952068, 4895.706257624536, 4940.283658869462, 4964.900701985958, 4841.273808928654, 4973.204287314031, 5050.671706339076, 5054.469280725526, 5086.92369614456, 4820.975895120537, 4850.320955066293, 4944.233643785219, 4963.925541116886, 4972.627052971042, 4857.78139983698, 4896.46138924718, 4924.359833221658, 4966.180580204262, 5048.1670524363435, 4915.877103072416, 4930.260460930853, 4946.554810067111, 4969.751512424365, 4995.975020124913, 5501.202325662756, 5520.641158324696, 5535.059039963216, 5539.14143307788, 5550.417206193372, 5757.136429535562, 5796.13058041293, 5889.411058894119, 5940.079287710412, 5963.940360596425, 6042.758289668408, 6043.607165534227, 6053.213082299273, 6055.788047418363, 6101.267847858286, 5617.494425501724, 5631.605787594829, 5636.379998200195, 5637.379888212294, 5645.0, 5896.587238893237, 5953.196318496947, 5962.493188078975, 5991.850203744854, 6134.0, 5742.196092547047, 5794.0439827428845, 5795.536357091422, 5812.564057695689, 5826.504747096545, 5803.0, 5879.764809407576, 5880.0, 5903.0260007099205, 5912.113183022581, 5682.346530149003, 5728.742206600713, 5832.387599302097, 5853.2976042875125, 5884.617499862496, 5928.229330187048, 5932.139839723302, 6002.0, 6005.279366476051, 6020.247469066367, 4573.81704731807, 4582.060677561092, 4583.381243532081, 4593.54064593538, 4621.630269578425, 4019.9196016079513, 4038.63652271297, 4087.836486540505, 4091.754494730326, 4128.855490057834, 5522.972385138129, 5586.245856809279, 5609.074502707089, 5665.745041473144, 5694.686792226385, 6001.339852616209, 6043.184170137063, 6044.274687037584, 6045.3652366501765, 6063.605865618721, 5593.62956075764, 5594.608377413623, 5626.493615574536, 5645.858853528613, 5655.943440565542, 4933.28467372229, 4961.5286547777905, 5059.494050594911, 5091.9236211456855, 5104.642675012788, 6188.381161883775, 6229.159063526366, 6231.034189700695, 6231.283402408691, 6233.563650544509, 6008.849778755566, 6021.157038014594, 6033.5173186145885, 6047.274327080779, 6103.206583144163, 5857.26784151981, 5873.647581145145, 5903.144044113666, 5981.551383646157, 6225.657588832477, 5692.48767610917, 5731.0, 5751.971240143773, 5752.769889204553, 5757.7121143941795, 5818.650880947157, 5832.387599302182, 5832.825015249549, 5842.152887831326, 5847.853803654943, 5693.231413759255, 5701.657900525982, 5704.914426283692, 5710.885782284414, 5711.371749107512, 5683.431656834284, 5687.800926967702, 5696.943030569641, 5699.316082070178, 5724.713764311851, 5583.330000399978, 5754.367019627922, 5776.989026920188, 5786.161006653927, 5794.536437084938, 5788.363280039108, 5843.678597676999, 5847.649141051551, 5852.268466441695, 5857.26784151981, 5762.827115186551, 5771.0, 5778.104393818965, 5779.595428319977, 5785.797497087582], "value": 5443.33648477402, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.6438404077248, 548.659830904839, 548.9588280878935, 553.5986409852857, 561.8904313658838, 34771.304573908536, 42648.14703705928, 44165.0, 44180.77909610452, 47994.0, 47746.28380574294, 48142.75928620361, 48225.27662085072, 48269.0, 48276.27585586219, 8840.115988401141, 9136.634534618608, 9143.634254629807, 9147.405418647766, 9148.588313525906, 10238.846417303746, 10540.736481587945, 10554.525046372893, 10852.945735271313, 10861.83707244392, 10596.894031059706, 10645.0, 10677.35935843848, 10684.358938463716, 10692.893071069306, 10707.83938240923, 10764.784704305948, 10769.353838769699, 10786.622468213653, 10791.99999999996, 10324.225683073724, 10381.532831022621, 10387.532561034772, 10397.48012599367, 10415.062644361968, 41068.38397424011, 41093.79453102715, 41277.0, 41407.0, 41411.792941035405, 3801.961980380216, 3831.6359945805384, 3849.1147036181555, 3853.441251018615, 3874.0314921269683, 30469.238269043228, 30700.2324941876, 30854.22864428385, 31304.060878173692, 32104.0, 4250.596193361625, 4429.224885645, 4433.822647094113, 4464.933026004613, 4593.035462552868, 344923.0, 348919.0, 349307.50692493, 349854.0, 350689.0, 56098.158527622116, 56714.7164264176, 56729.0, 57085.71457142688, 57086.42913570811, 60534.39465605376, 60861.08708369378, 60945.0, 61133.69433152806, 61193.38806611966, 16987.830121698626, 17428.12859357027, 17440.86634368762, 17449.825501745076, 17457.738133928, 12015.699607509881, 12227.0, 12856.935715321364, 12921.353932303347, 13019.0, 17542.842288388212, 17761.911190444225, 18151.364702235358, 18336.63326733458, 18446.631067378577, 6896.0, 7079.964600177069, 7224.891626625605, 7401.925980740231, 7430.368418684364, 953.4517652349788, 966.917811985975, 969.4682401805131, 982.6315131825565, 993.2302465589082, 29984.40031199364, 32263.838680806446, 32593.511097333558, 32765.50851737178, 33495.0, 1079.9676009719722, 1102.151343465543, 1128.785530749155, 1131.6209069961656, 1145.2899202494507, 14976.47582334613, 15152.621184470476, 15427.0, 15448.227588620748, 15764.975276606983, 507699.0, 508065.0, 509689.0, 510509.0, 510546.0, 54501.72749136229, 54759.726201369536, 54965.450345496836, 54987.72506137444, 55233.0, 1474.2555009720022, 1478.8595083467053, 1498.0, 1504.638886667192, 1509.3208056374676, 28448.146555603365, 29218.0, 29538.0, 29582.112536623936, 30073.849630751705, 50165.74917125391, 51171.48828511816, 51359.486405136966, 51422.74288628533, 51438.74280628573, 502632.0, 503172.0, 504514.0, 505461.9811117938, 506729.0, 23991.0, 24123.75876241215, 26920.32699182536, 27404.451910962067, 27445.725542745116, 38554.0, 42842.35736464018, 43138.35292470553, 43145.0, 43498.34752478652, 37238.0, 37644.2471150581, 38015.239695206496, 39473.0, 39908.2018359637, 37007.47240557992, 37793.62206378011, 37864.05339866525, 38922.416163757, 39101.41347879727, 36995.815020924725, 37456.25087498289, 38217.4267385995, 38222.80888595539, 38277.23445531129, 31721.0, 33573.83213083919, 33655.0, 33780.15549611279, 33929.49105763465, 25483.6177457342, 25660.743392566583, 25716.614250786628, 25739.356516087246, 25917.0], "value": 20128.13074823831, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.33284816217474, 424.35074336265484, 433.5599366642857, 435.17968629134083, 445.25197667917905, 19720.90139549302, 21709.3487195384, 21849.016794244257, 22471.438214044658, 22611.0, 21770.0, 22097.226597069104, 22110.33668989929, 22235.22176723815, 22301.44246393841, 5710.828675139732, 5946.405359464041, 5956.851078723045, 5997.310309314441, 6000.399960003986, 5731.254936858202, 5924.763009479637, 5944.078667806497, 5979.073243647242, 5992.700364981755, 5728.914066289009, 5907.995640741063, 5924.289085309769, 5927.051671732524, 5958.9702051489685, 5826.650400975934, 5911.231539899829, 5912.556558258105, 5922.3485416604135, 5934.792282270143, 5292.047431462335, 5323.707196104213, 5340.893182136374, 5343.973280133613, 5347.197920311945, 23577.646335304984, 23581.528369432515, 23726.05095796166, 23766.0, 23810.52378952411, 2814.957775633367, 2839.54567269238, 2843.772498200139, 2846.9145925622265, 2853.2724155340256, 15195.848041519554, 15966.920165399215, 16048.0, 16191.676166476722, 16589.17054147288, 1965.263026365113, 2038.2865996901114, 2041.4386043837915, 2046.9897650511653, 2050.1286953044896, 84329.73505397423, 88693.11306886913, 89279.55360223222, 90363.0, 90848.54575727145, 11586.88413115858, 11683.357415342069, 11819.349935753617, 11919.344436055926, 12063.0, 16710.916445417937, 16834.915825420794, 16869.0, 16919.746203806953, 16958.915205424142, 8593.355498337525, 8738.38831281817, 8871.290296776242, 8999.730008099768, 9033.683821066232, 8334.083250842403, 8375.748727538183, 8388.37087218461, 8525.275351595184, 8633.611487483078, 7417.21589574732, 7518.812029699301, 7555.508891922007, 7679.539227646359, 7772.989511363599, 2022.2699355869458, 2051.210284040625, 2059.4954236211925, 2142.6036183306137, 2164.1235299703644, 931.5668214280392, 946.2288235088381, 946.4983558713893, 950.064186776025, 951.4671783801093, 19610.215591376185, 21506.83294155163, 21588.56822863534, 21707.13171473155, 21725.565488690452, 938.7653086728318, 944.329526036508, 945.229637845154, 970.3644113105927, 977.8728765260613, 11994.940025299818, 12181.573644922562, 12280.263184208976, 12304.569340073054, 12319.0, 639654.0, 649578.0, 653285.0, 657086.0, 660650.0, 95814.52092739491, 96061.4332423433, 96331.51834240924, 96953.5152324234, 98527.50736246273, 1096.9725756855983, 1109.0905457524914, 1113.6993011886746, 1118.8713297970676, 1121.198343184627, 18416.35542755997, 18474.353397631017, 18775.812241877407, 18779.154938028096, 19031.42905712831, 42977.14045719006, 43010.35484467673, 43213.567864320954, 43681.907952301444, 44177.77911110424, 56999.71500142639, 57417.42582574121, 57842.4215757837, 65120.348796513324, 66556.0, 9179.219766319937, 9238.95380523093, 9452.10205030521, 9461.101195386427, 9578.233741300819, 13873.4450621974, 14365.281735912953, 14387.712245755236, 14424.350904209126, 14737.0, 11657.650270491898, 12268.570600028956, 12519.061070419937, 12640.494380224687, 12883.677908052, 12270.32513211782, 12771.680707982003, 12805.295708736108, 13208.405621747237, 13225.669358266121, 12692.428840702007, 12837.229766214057, 12900.870991290343, 12913.548025819051, 12939.288339141438, 9274.489903055126, 9380.108889655472, 9493.382930109521, 9530.809383812146, 9659.71020869375, 11297.943510282395, 12536.874631253571, 12582.811257830957, 12833.486660533474, 13053.28206948627], "value": 10136.157789933743, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.6418977350552, 1465.772805215192, 1480.748272793625, 1483.9925800370997, 1493.4847477620222, 7341.5962122083265, 7639.579823109741, 7806.102298235704, 8229.053658829236, 8263.545504997222, 7856.0, 8135.7152499662525, 8172.59137043147, 8342.74971750847, 8357.707480238192, 2283.063943783049, 2306.0, 2310.4570425949887, 2320.721513418392, 2325.534893021394, 2325.872077035771, 2353.988230058856, 2367.3371455992265, 2370.182287110944, 2378.3935096550354, 2338.0530884991604, 2356.646503024543, 2369.5024044950583, 2374.4301367671806, 2376.6791483149727, 2170.9891450542805, 2202.2512345802425, 2257.7290725112925, 2282.4978504728933, 2285.06312411912, 2268.4442311633757, 2268.965965510519, 2276.3398614401804, 2287.2795069553204, 2292.1289909834154, 8180.713675021346, 8219.136990616018, 8234.300084492825, 8253.174682531699, 8358.791030224233, 4982.90034199314, 5084.923726144111, 5086.389633243997, 5098.643094983353, 5101.260317254015, 3028.212664707192, 3132.9686703132907, 3292.8024318540965, 3293.7859039162377, 3299.3236386540702, 1284.7688064517745, 1307.941142648583, 1320.7094439223451, 1321.8876395506393, 1335.5859683498147, 11004.229703920728, 11100.500477478532, 11122.721931951684, 11155.330680159217, 11217.831732524019, 4472.105578884236, 4554.521775213621, 4645.674802763774, 4711.363965864564, 4770.713757174581, 9597.664081757104, 9649.903500965042, 9689.321747477608, 9703.320767546204, 9726.70819875405, 5194.32473778414, 5225.137852254412, 5228.215767634885, 5239.973800130975, 5255.5795536357, 4171.290880550314, 4216.8313267469575, 4796.088743138793, 4813.181759100961, 4840.419149702058, 3859.845606175778, 3911.9217615647526, 3913.2173565287057, 3992.3612222044335, 4019.598040195957, 1284.800855867342, 1287.291989405823, 1296.695276609996, 1301.7852054410916, 1311.3770958794687, 994.174834887042, 999.3703966501204, 1007.7329507680471, 1020.8519764634235, 1022.9795404091876, 5544.473275038865, 5563.888722225533, 5807.912881306784, 5911.379305172981, 6000.969995150083, 1066.36018388966, 1071.7159952612565, 1077.9946100269606, 1081.9242653014371, 1100.6037826382496, 3939.7242193046213, 3944.1914407546383, 3979.7811120388656, 4014.437978682987, 4015.5181378234215, 9730.270229732656, 9937.503124843874, 10011.44937028456, 10050.648227312155, 10107.241956853119, 9804.166645835041, 9860.950695246622, 9866.260030497742, 9951.353162044445, 9961.153301969269, 7443.516171448839, 7751.1861254568585, 7799.45403821727, 7871.0, 7927.5243485391065, 5494.697791621499, 5608.4111168326735, 5699.088145896637, 5749.942500574941, 5779.422057794187, 8882.245009174292, 8952.865707014269, 9014.233790127913, 9045.0, 9137.954310228406, 9065.818683626423, 9095.363324567217, 9102.499362535124, 9154.771130721785, 9231.907680923105, 6994.370506654425, 7240.203577606564, 7301.853962920818, 7386.926130738624, 7401.185869554452, 8019.6391162398995, 8056.355491560544, 8071.273585377344, 8099.392545559224, 8110.878336825071, 7181.0, 7201.4238860889955, 7375.8156046099275, 7485.4385921055045, 7515.549067055994, 6889.345512176335, 6975.162980442379, 7004.929950700632, 7024.473164512579, 7063.540869843444, 6397.072424498515, 6532.444742196776, 6538.640374779433, 6546.8363290918105, 6561.639109848813, 4993.27597498368, 5067.670601410897, 5098.643094983316, 5191.428942816212, 5214.843554693365, 4947.554720075211, 5029.170186919264, 5109.514596113363, 5118.206677964921, 5128.717920514258], "value": 4490.302245295413, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.53488418550296, 407.7512717242482, 412.8947118484786, 413.0520455554504, 418.54169684195807, 5318.25544423781, 5470.152126420411, 5507.36665283492, 5539.501444869961, 5576.302962129734, 5372.91940620891, 5375.193720941861, 5378.865528361793, 5403.486668766461, 5414.810481633143, 4140.31684772013, 4164.895877603069, 4185.372194170884, 4196.685248606352, 4210.936835947448, 3998.6001399860074, 4168.5623009584015, 4204.348326009458, 4221.577842215769, 4265.146970605876, 4131.876043718693, 4138.496209793077, 4142.233686767958, 4147.668186545069, 4163.39630753542, 4140.648044916185, 4160.687948403852, 4171.207470580595, 4178.958210417887, 4203.831846726127, 3725.8137093145233, 3739.906502337436, 3755.962440375589, 3761.1725420407465, 3762.811859407019, 5205.609579281569, 5244.449332820037, 5288.0, 5292.973535132338, 5307.787688492455, 4860.343853579757, 4874.46380898101, 4879.268109783526, 4883.413990321149, 4896.290037944478, 5500.944990550123, 5707.429257074259, 5743.822516384173, 5754.367019627837, 5798.681072541009, 4094.447249621293, 4109.137081212949, 4111.9177616447805, 4116.0, 4121.5466298707115, 5886.7939622113445, 5887.470127688529, 5951.375105613892, 5969.403059694039, 5990.341062483123, 4189.476315460567, 4204.453421055305, 4206.422591528177, 4222.733180045974, 4256.7658778766845, 4059.1475790083823, 4239.830406783756, 4272.829086836554, 4278.7432754034235, 4308.138372325548, 4854.368932038883, 4855.9074208303555, 4858.902821943541, 4872.561469467694, 4905.920697446556, 5736.42635736423, 5806.21616081832, 5833.7083145842535, 5857.179994800731, 5858.326292476335, 1419.7718973088204, 1424.3803945283628, 1434.3258668425824, 1437.4322142753554, 1438.2377340009812, 961.5480724059681, 990.7622170678985, 995.8307087795092, 997.7705127820642, 1013.640157744005, 5271.947280527145, 5331.386890507563, 5333.386660534088, 5339.652922560022, 5349.866253343697, 5550.0, 5610.0, 5663.405342439067, 5663.858403539862, 5679.586175875236, 5189.662671926313, 5232.529072383428, 5379.300690910235, 5420.593455490854, 5441.8572099859475, 2976.9851150744107, 3005.9549106763416, 3017.5171972484736, 3043.8630261638277, 3050.2679356954172, 5934.9406505934385, 5949.851253718605, 5950.523958083343, 5957.463828255478, 5965.791197308074, 5700.263873340737, 6018.548608854353, 6049.879002419927, 6056.515478761777, 6092.878142437126, 6133.53998450127, 6141.57009009374, 6145.0782382642965, 6156.6921653917125, 6187.721552530147, 5592.909382670503, 5815.738291776965, 5858.543459358999, 5902.675352855634, 5913.408659134224, 5801.883962320646, 5803.767849285981, 5829.679367634821, 5842.83143371319, 5908.379620139824, 5836.0, 6076.665783381956, 6084.0757711276865, 6145.631262124287, 6151.323354431099, 4125.91748165041, 4163.8959026024595, 4224.218519573888, 4235.957640423557, 4243.68172387066, 5872.442117998783, 5896.054302080217, 5897.0, 5897.351291358033, 5908.4593624740055, 5745.798897038583, 5751.849630073918, 5753.971230143822, 5754.625949313281, 5757.309122905278, 5620.85947851307, 5756.165356023437, 5790.305163380422, 5793.15999180125, 5836.124581312667, 5662.518685911744, 5703.714814259353, 5744.597878148489, 5761.48146666802, 5772.855678608068, 5455.481729235717, 5773.393793651774, 5800.186909349047, 5814.854628634318, 5823.475887170175, 5647.29408823897, 5649.209110724584, 5664.660120392789, 5668.433156684464, 5671.546276297804], "value": 4372.857672979259, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.8696478116332, 745.8210029592899, 785.4462603864276, 857.0211332494476, 889.3952112563456, 17109.315627374905, 17947.730784038235, 18014.72977905329, 18016.099195040228, 18073.638527229446, 17630.0, 17725.82274177258, 17744.645107097884, 17745.911270443663, 17943.64112717748, 735.1325435985535, 740.7555506682809, 758.4008633179809, 760.7337431898819, 766.0, 765.6898955922833, 772.8995230620039, 773.0877564473918, 773.7253275087347, 773.9767806965772, 800.5036877136183, 802.6027116577302, 802.6468353924283, 803.1847674610275, 803.8794180872858, 791.2206476620581, 793.0404210904783, 793.7261644732558, 796.2515235678444, 798.1778767869104, 587.3744462147799, 587.870668452944, 588.2323567744093, 588.3410580150216, 588.3675049321953, 16157.596060098474, 16537.421190258403, 16577.751333730004, 16635.334586616522, 16761.66476670472, 14817.555473335817, 14989.250537473192, 15445.0, 15699.843001569952, 15731.292091855894, 12180.878191218064, 12296.508139674403, 12323.753524929542, 12346.629601111981, 12430.316332601704, 3732.682721968636, 3755.6432138946757, 3793.943090853639, 3799.886003419902, 3823.9044023899346, 88819.55590222072, 89832.55083724605, 90208.5489572548, 90812.0, 91655.54172229163, 12106.394680266128, 12183.512659493521, 12186.878131218751, 12189.573364932185, 12253.877461225451, 24098.51802963966, 24295.27114186577, 24306.0, 24325.635115473284, 24411.511769764504, 7774.1837107104075, 7794.532328060334, 7895.802604934923, 8074.071481779553, 8150.959245203855, 4227.175700738327, 4259.936100958488, 4271.658267338606, 4343.1530851484285, 4351.303791393425, 3613.457981302773, 3649.6496296369983, 3687.7602955808325, 3704.3517384457614, 3717.4795528626014, 676.0298970976664, 677.9965650836789, 680.0649107477219, 688.4629988608793, 691.9757808476679, 785.7917651822272, 786.1077676836832, 797.6928882380325, 811.6550466051905, 829.9751007469786, 10659.360438373722, 10764.643301317186, 10903.0, 10912.563497460013, 11014.44927753609, 648.7988723495731, 651.26407159909, 667.0860920538893, 672.6872004517923, 672.7712577723597, 5036.093503169392, 5230.660007099603, 5265.921011184835, 5273.973630131824, 5284.841454756286, 88105.0, 88900.0, 89388.0, 89995.55002225078, 91782.0, 63066.36933630697, 63243.0, 64267.0, 64279.0, 79632.60183699045, 62919.37080629227, 63992.0, 64648.0, 65051.67474162599, 65691.0, 10483.475826208507, 10942.343459392461, 11040.171987100839, 11182.217244793112, 11218.158638102339, 43640.781796090814, 43798.56201437945, 45020.0, 45518.544814552755, 45663.31505027361, 43531.0, 44112.33831492466, 48721.51278487311, 54632.45367546273, 55128.72435637796, 13120.0, 13232.470701172231, 13396.732065358834, 13731.176129432266, 13796.310184490534, 14453.49412770548, 14575.489857854924, 14609.780853287422, 14694.191819450032, 15545.756339492587, 13478.730425391634, 13579.59261222165, 13630.522931697344, 14264.358103885557, 14268.857311426753, 13832.239226842621, 13931.512397066459, 14815.92592037033, 15242.237888105328, 16022.519324420286, 14107.647308817363, 14487.92756036213, 14550.345234464687, 14565.0, 14644.560663180122, 11286.66140015801, 11786.941065294619, 11965.76068478608, 12300.0, 12602.0, 10855.945720271347, 12255.69360765988, 12272.38638068111, 12299.508019679113, 12681.175723577939], "value": 7526.741225153586, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 111.0, 111.0, 112.0, 110.0, 113.0, 116.0, 115.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 118.0, 118.0, 170.0, 119.0, 120.0, 117.0, 119.0, 141.0, 124.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 163.0, 164.0, 167.0, 166.0, 164.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 102.0, 78.0, 79.0, 78.0, 77.0, 102.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 114.0, 83.0, 84.0, 84.0, 98.0, 84.0, 85.0, 104.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 122.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 103.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0], "value": 97.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 56.0, 58.0, 58.0, 58.0, 57.0, 63.0, 57.0, 56.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 67.0, 67.0, 68.0, 72.0, 69.0, 68.0, 70.0, 68.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 82.0, 82.0, 83.0, 82.0, 82.0, 82.0, 83.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 130.0, 140.0, 137.0, 127.0, 127.0, 126.0, 168.0, 142.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 168.0, 171.0, 173.0, 171.0, 167.0, 188.0, 169.0, 167.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 68.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 65.0], "value": 64.1, "unit": "score"}]}]} 14:43:19 INFO - Return code: 0 14:43:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:43:19 ERROR - # TBPL SUCCESS # 14:43:19 INFO - Running post-action listener: _resource_record_post_action 14:43:19 INFO - [mozharness: 2017-01-09 22:43:19.883358Z] Finished run-tests step (success) 14:43:19 INFO - Running post-run listener: _resource_record_post_run 14:43:19 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400945152; Read time: 12; Write time: 331736 14:43:19 INFO - TinderboxPrint: CPU usage
13.4% 14:43:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:43:19 INFO - TinderboxPrint: I/O write bytes / time
400,945,152 / 331,736 14:43:19 INFO - TinderboxPrint: CPU idle
8,245.7 (86.5%) 14:43:19 INFO - TinderboxPrint: CPU user
1,219.5 (12.8%) 14:43:19 INFO - TinderboxPrint: Swap in / out
0 / 0 14:43:19 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 105373696; Read time: 0; Write time: 86800 14:43:19 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 295190528; Read time: 0; Write time: 244936 14:43:20 INFO - Running post-run listener: _upload_blobber_files 14:43:20 INFO - Blob upload gear active. 14:43:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:43:20 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 14:43:20 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'] 14:43:20 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 14:43:20 INFO - (blobuploader) - INFO - Open directory for files ... 14:43:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:43:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:43:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:21 INFO - (blobuploader) - INFO - Done attempting. 14:43:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:43:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:43:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:25 INFO - (blobuploader) - INFO - Done attempting. 14:43:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:43:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:43:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:26 INFO - (blobuploader) - INFO - Done attempting. 14:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:43:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:43:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:27 INFO - (blobuploader) - INFO - Done attempting. 14:43:27 INFO - (blobuploader) - INFO - Iteration through files over. 14:43:27 INFO - Return code: 0 14:43:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:43:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:43:27 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2ddaecbbd8e7fdaa2c0f7d39af0bf43548fb47002a04304521aad23a306d7c07eb5ee0197211dcbb79c9ab405ee698a0cbaba45b6a65e76e0a3f4a9ddce7f05f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9727029d95ea10b92438672c576911d3ad423bde595d13cbc015fa20a325d01212cd03308e541e3d38d67d784279a173b1dfd53097ffa875a08094c258ae7625", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69fb74fc2caa43a38e6c9f203212170cf05e0a5cdf360070e61ca06050e159bc9360b2679922873459cfe487a38e3cf60cdc1a48a5be010d80e1eb4272e11108", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05595e6cbcf469c1670a96153248659068fc3cfa1ddec3dd8257b5e266f4c69c8cc3ad6ec57f6628ddd7bebc0822c751a9a415f73a145b69d96ec83339ec9e75"} 14:43:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:43:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:43:27 INFO - Contents: 14:43:27 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2ddaecbbd8e7fdaa2c0f7d39af0bf43548fb47002a04304521aad23a306d7c07eb5ee0197211dcbb79c9ab405ee698a0cbaba45b6a65e76e0a3f4a9ddce7f05f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9727029d95ea10b92438672c576911d3ad423bde595d13cbc015fa20a325d01212cd03308e541e3d38d67d784279a173b1dfd53097ffa875a08094c258ae7625", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69fb74fc2caa43a38e6c9f203212170cf05e0a5cdf360070e61ca06050e159bc9360b2679922873459cfe487a38e3cf60cdc1a48a5be010d80e1eb4272e11108", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05595e6cbcf469c1670a96153248659068fc3cfa1ddec3dd8257b5e266f4c69c8cc3ad6ec57f6628ddd7bebc0822c751a9a415f73a145b69d96ec83339ec9e75"} 14:43:27 INFO - Running post-run listener: copy_logs_to_upload_dir 14:43:27 INFO - Copying logs to upload dir... 14:43:27 INFO - mkdir: /builds/slave/test/build/upload/logs 14:43:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.792062 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-01-09 14:43:27.115921) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 14:43:27.119551) ========= 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-1484000265.562590-1220045572 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/2ddaecbbd8e7fdaa2c0f7d39af0bf43548fb47002a04304521aad23a306d7c07eb5ee0197211dcbb79c9ab405ee698a0cbaba45b6a65e76e0a3f4a9ddce7f05f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9727029d95ea10b92438672c576911d3ad423bde595d13cbc015fa20a325d01212cd03308e541e3d38d67d784279a173b1dfd53097ffa875a08094c258ae7625", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69fb74fc2caa43a38e6c9f203212170cf05e0a5cdf360070e61ca06050e159bc9360b2679922873459cfe487a38e3cf60cdc1a48a5be010d80e1eb4272e11108", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05595e6cbcf469c1670a96153248659068fc3cfa1ddec3dd8257b5e266f4c69c8cc3ad6ec57f6628ddd7bebc0822c751a9a415f73a145b69d96ec83339ec9e75"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483994107/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/2ddaecbbd8e7fdaa2c0f7d39af0bf43548fb47002a04304521aad23a306d7c07eb5ee0197211dcbb79c9ab405ee698a0cbaba45b6a65e76e0a3f4a9ddce7f05f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9727029d95ea10b92438672c576911d3ad423bde595d13cbc015fa20a325d01212cd03308e541e3d38d67d784279a173b1dfd53097ffa875a08094c258ae7625", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69fb74fc2caa43a38e6c9f203212170cf05e0a5cdf360070e61ca06050e159bc9360b2679922873459cfe487a38e3cf60cdc1a48a5be010d80e1eb4272e11108", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05595e6cbcf469c1670a96153248659068fc3cfa1ddec3dd8257b5e266f4c69c8cc3ad6ec57f6628ddd7bebc0822c751a9a415f73a145b69d96ec83339ec9e75"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 14:43:27.145086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:43:27.145438) ========= 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-1484000265.562590-1220045572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:43:27.230927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 14:43:27.231258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 14:43:27.231550) ========= ========= Total master_lag: 0.16 =========