builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1483655549.61 results: success (0) buildid: 20170105142944 builduid: 2fa17cdd4c7346a18410e005097109f7 revision: c484c1e7eeb61f4abd6d9e2352eacd52b1a47cbf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:29.607842) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:29.608271) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:29.608558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:29.620618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:29.620974) ========= 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=745a4373a2a16df560f216e000000264-1483655549.434659-1554256573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-05 14:32:30-- 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% 45.9M=0s 2017-01-05 14:32:30 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.366997 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:29.999413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:29.999751) ========= 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=745a4373a2a16df560f216e000000264-1483655549.434659-1554256573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015703 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:30.049330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:30.049689) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c484c1e7eeb61f4abd6d9e2352eacd52b1a47cbf --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 c484c1e7eeb61f4abd6d9e2352eacd52b1a47cbf --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=745a4373a2a16df560f216e000000264-1483655549.434659-1554256573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-05 14:32:30,575 truncating revision to first 12 chars 2017-01-05 14:32:30,575 Setting DEBUG logging. 2017-01-05 14:32:30,575 attempt 1/10 2017-01-05 14:32:30,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c484c1e7eeb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 14:32:30,881 unpacking tar archive at: mozilla-inbound-c484c1e7eeb6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654462 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:30.717352) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:30.717682) ========= script_repo_revision: c484c1e7eeb61f4abd6d9e2352eacd52b1a47cbf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:30.718069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:30.718341) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 14:32:30.728817) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-01-05 14:32:30.729116) ========= /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=745a4373a2a16df560f216e000000264-1483655549.434659-1554256573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:32:31 INFO - MultiFileLogger online at 20170105 14:32:31 in /builds/slave/test 14:32:31 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:32:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:32:31 INFO - {'append_to_log': False, 14:32:31 INFO - 'base_work_dir': '/builds/slave/test', 14:32:31 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 14:32:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:32:31 INFO - 'branch': 'Mozilla-Inbound', 14:32:31 INFO - 'buildbot_json_path': 'buildprops.json', 14:32:31 INFO - 'config_files': ('talos/linux_config.py',), 14:32:31 INFO - 'default_actions': ('clobber', 14:32:31 INFO - 'read-buildbot-config', 14:32:31 INFO - 'download-and-extract', 14:32:31 INFO - 'populate-webroot', 14:32:31 INFO - 'create-virtualenv', 14:32:31 INFO - 'install', 14:32:31 INFO - 'run-tests'), 14:32:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:32:31 INFO - 'download_minidump_stackwalk': True, 14:32:31 INFO - 'download_symbols': 'ondemand', 14:32:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:32:31 INFO - 'tooltool.py': '/tools/tooltool.py', 14:32:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:32:31 INFO - '/tools/misc-python/virtualenv.py')}, 14:32:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:32:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:32:31 INFO - 'installer_path': 'installer.exe', 14:32:31 INFO - 'log_level': 'info', 14:32:31 INFO - 'log_name': 'talos', 14:32:31 INFO - 'log_to_console': True, 14:32:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:32:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:32:31 INFO - 'opt_config_files': (), 14:32:31 INFO - 'pip_index': False, 14:32:31 INFO - 'sps_profile': False, 14:32:31 INFO - 'sps_profile_interval': 0, 14:32:31 INFO - 'suite': 'dromaeojs-e10s', 14:32:31 INFO - 'system_bits': '32', 14:32:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:32:31 INFO - 'title': 'talos-linux64-ix-032', 14:32:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:32:31 INFO - 'use_talos_json': True, 14:32:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:32:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:32:31 INFO - 'work_dir': 'build'} 14:32:31 INFO - [mozharness: 2017-01-05 22:32:31.350052Z] Running clobber step. 14:32:31 INFO - Running pre-action listener: _resource_record_pre_action 14:32:31 INFO - Running main action method: clobber 14:32:31 INFO - rmtree: /builds/slave/test/build 14:32:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:32:31 INFO - Running post-action listener: _resource_record_post_action 14:32:31 INFO - [mozharness: 2017-01-05 22:32:31.814438Z] Finished clobber step (success) 14:32:31 INFO - [mozharness: 2017-01-05 22:32:31.814538Z] Running read-buildbot-config step. 14:32:31 INFO - Running pre-action listener: _resource_record_pre_action 14:32:31 INFO - Running main action method: read_buildbot_config 14:32:31 INFO - Using buildbot properties: 14:32:31 INFO - { 14:32:31 INFO - "project": "", 14:32:31 INFO - "product": "firefox", 14:32:31 INFO - "script_repo_revision": "production", 14:32:31 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 14:32:31 INFO - "repository": "", 14:32:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 14:32:31 INFO - "buildid": "20170105142944", 14:32:31 INFO - "stage_platform": "linux64-pgo", 14:32:31 INFO - "basedir": "/builds/slave/test", 14:32:31 INFO - "buildnumber": 2417, 14:32:31 INFO - "platform": "ubuntu64_hw", 14:32:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:32:31 INFO - "slavebuilddir": "test", 14:32:31 INFO - "branch": "mozilla-inbound", 14:32:31 INFO - "revision": "c484c1e7eeb61f4abd6d9e2352eacd52b1a47cbf", 14:32:31 INFO - "slavename": "talos-linux64-ix-032", 14:32:31 INFO - "builduid": "2fa17cdd4c7346a18410e005097109f7", 14:32:31 INFO - "repo_path": "integration/mozilla-inbound" 14:32:31 INFO - } 14:32:31 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 14:32:31 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 14:32:31 INFO - Running post-action listener: _resource_record_post_action 14:32:31 INFO - [mozharness: 2017-01-05 22:32:31.816892Z] Finished read-buildbot-config step (success) 14:32:31 INFO - [mozharness: 2017-01-05 22:32:31.816980Z] Running download-and-extract step. 14:32:31 INFO - Running pre-action listener: _resource_record_pre_action 14:32:31 INFO - Running main action method: download_and_extract 14:32:31 INFO - mkdir: /builds/slave/test/build/tests 14:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:32:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/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:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/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:32:31 INFO - Downloaded 1361 bytes. 14:32:31 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:32:31 INFO - Using the following test package requirements: 14:32:31 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:32:31 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:32:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:32:31 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:32:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:32:31 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:32:31 INFO - u'jsshell-linux-x86_64.zip'], 14:32:31 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:32:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:32:31 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:32:31 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:32:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:32:31 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:32:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:32:31 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:32:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:32:31 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:32:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:32:31 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:32:31 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/1483648504/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:32:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:32:31 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:32:32 INFO - Expected file size: 21834724 14:32:32 INFO - Obtained file size: 21834724 14:32:36 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:32:36 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/1483648504/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:32:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:32:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:32:36 INFO - Expected file size: 21834724 14:32:36 INFO - Obtained file size: 21834724 14:32:41 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/1483648504/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 14:32:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:32:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:32:41 INFO - Expected file size: 14403730 14:32:41 INFO - Obtained file size: 14403730 14:32:41 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:32:41 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:32:41 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/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:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/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:32:42 INFO - Downloaded 61347495 bytes. 14:32:42 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:32:42 INFO - mkdir: /builds/slave/test/properties 14:32:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:32:42 INFO - Writing to file /builds/slave/test/properties/build_url 14:32:42 INFO - Contents: 14:32:42 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:32:42 INFO - Running post-action listener: _resource_record_post_action 14:32:42 INFO - Running post-action listener: set_extra_try_arguments 14:32:42 INFO - [mozharness: 2017-01-05 22:32:42.538837Z] Finished download-and-extract step (success) 14:32:42 INFO - [mozharness: 2017-01-05 22:32:42.539140Z] Running populate-webroot step. 14:32:42 INFO - Running pre-action listener: _resource_record_pre_action 14:32:42 INFO - Running main action method: populate_webroot 14:32:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:42 INFO - '--tppagecycles', 14:32:42 INFO - '7'], 14:32:42 INFO - 'tests': ['tsvgm']}}, 14:32:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:32:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:32:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:32:42 INFO - 'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:32:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:32:42 INFO - 'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['damp', 'tps']}, 14:32:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:32:42 INFO - 'tests': ['damp', 'tps']}, 14:32:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['dromaeo_dom']}, 14:32:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['basic_compositor_video']}, 14:32:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:32:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['a11yr', 14:32:42 INFO - 'ts_paint', 14:32:42 INFO - 'tpaint', 14:32:42 INFO - 'sessionrestore', 14:32:42 INFO - 'sessionrestore_no_auto_restore', 14:32:42 INFO - 'tabpaint']}, 14:32:42 INFO - 'other-e10s': {'tests': ['a11yr', 14:32:42 INFO - 'ts_paint', 14:32:42 INFO - 'tpaint', 14:32:42 INFO - 'sessionrestore', 14:32:42 INFO - 'sessionrestore_no_auto_restore', 14:32:42 INFO - 'tabpaint']}, 14:32:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:32:42 INFO - 'ts_paint', 14:32:42 INFO - 'tpaint', 14:32:42 INFO - 'sessionrestore', 14:32:42 INFO - 'sessionrestore_no_auto_restore', 14:32:42 INFO - 'tabpaint']}, 14:32:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:32:42 INFO - 'ts_paint', 14:32:42 INFO - 'tpaint', 14:32:42 INFO - 'sessionrestore', 14:32:42 INFO - 'sessionrestore_no_auto_restore', 14:32:42 INFO - 'tabpaint']}, 14:32:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['a11yr', 14:32:42 INFO - 'ts_paint', 14:32:42 INFO - 'tpaint', 14:32:42 INFO - 'sessionrestore', 14:32:42 INFO - 'sessionrestore_no_auto_restore', 14:32:42 INFO - 'tabpaint']}, 14:32:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['a11yr', 14:32:42 INFO - 'ts_paint', 14:32:42 INFO - 'tpaint', 14:32:42 INFO - 'sessionrestore', 14:32:42 INFO - 'sessionrestore_no_auto_restore', 14:32:42 INFO - 'tabpaint']}, 14:32:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['tsvgx', 14:32:42 INFO - 'tsvgr_opacity', 14:32:42 INFO - 'tart', 14:32:42 INFO - 'tscrollx', 14:32:42 INFO - 'cart', 14:32:42 INFO - 'tsvg_static']}, 14:32:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:32:42 INFO - 'tsvgr_opacity', 14:32:42 INFO - 'tart', 14:32:42 INFO - 'tscrollx', 14:32:42 INFO - 'cart', 14:32:42 INFO - 'tsvg_static']}, 14:32:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:32:42 INFO - 'talos_options': ['--disable-e10s'], 14:32:42 INFO - 'tests': ['tp5o']}, 14:32:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:32:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:32:42 INFO - 'talos_options': ['--disable-e10s', 14:32:42 INFO - '--xperf_path', 14:32:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:42 INFO - 'tests': ['tp5n']}, 14:32:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:32:42 INFO - 'talos_options': ['--xperf_path', 14:32:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:42 INFO - 'tests': ['tp5n']}}, 14:32:42 INFO - 'talos.zip': {'path': '', 14:32:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:42 INFO - Running post-action listener: _resource_record_post_action 14:32:42 INFO - [mozharness: 2017-01-05 22:32:42.556951Z] Finished populate-webroot step (success) 14:32:42 INFO - [mozharness: 2017-01-05 22:32:42.557046Z] Running create-virtualenv step. 14:32:42 INFO - Running pre-action listener: _resource_record_pre_action 14:32:42 INFO - Running main action method: create_virtualenv 14:32:42 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:42 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:32:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:42 INFO - Using real prefix '/usr' 14:32:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:43 INFO - Installing distribute.............................................................................................................................................................................................done. 14:32:45 INFO - Installing pip.................done. 14:32:45 INFO - Return code: 0 14:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:32:45 INFO - Reading from file tmpfile_stdout 14:32:45 INFO - Output received: 14:32:45 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:32:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:32:45 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:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:45 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:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:45 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 0x201a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, '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': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', '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:32:45 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:32:45 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:32:45 INFO - Using env: {'DISPLAY': ':0', 14:32:45 INFO - 'HOME': '/home/cltbld', 14:32:45 INFO - 'LANG': 'en_US.UTF-8', 14:32:45 INFO - 'LANGUAGE': 'en_US:en', 14:32:45 INFO - 'LOGNAME': 'cltbld', 14:32:45 INFO - 'MAIL': '/var/mail/cltbld', 14:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:45 INFO - 'MOZ_NO_REMOTE': '1', 14:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:45 INFO - 'NO_EM_RESTART': '1', 14:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:45 INFO - 'PWD': '/builds/slave/test', 14:32:45 INFO - 'SHELL': '/bin/bash', 14:32:45 INFO - 'SHLVL': '1', 14:32:45 INFO - 'TERM': 'linux', 14:32:45 INFO - 'TMOUT': '86400', 14:32:45 INFO - 'USER': 'cltbld', 14:32:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:45 INFO - '_': '/tools/buildbot/bin/python'} 14:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:45 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:32:45 INFO - Cleaning up... 14:32:45 INFO - Return code: 0 14:32:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:32:45 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:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:45 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:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:45 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 0x201a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, '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': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', '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:32:45 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:32:45 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:32:45 INFO - Using env: {'DISPLAY': ':0', 14:32:45 INFO - 'HOME': '/home/cltbld', 14:32:45 INFO - 'LANG': 'en_US.UTF-8', 14:32:45 INFO - 'LANGUAGE': 'en_US:en', 14:32:45 INFO - 'LOGNAME': 'cltbld', 14:32:45 INFO - 'MAIL': '/var/mail/cltbld', 14:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:45 INFO - 'MOZ_NO_REMOTE': '1', 14:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:45 INFO - 'NO_EM_RESTART': '1', 14:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:45 INFO - 'PWD': '/builds/slave/test', 14:32:45 INFO - 'SHELL': '/bin/bash', 14:32:45 INFO - 'SHLVL': '1', 14:32:45 INFO - 'TERM': 'linux', 14:32:45 INFO - 'TMOUT': '86400', 14:32:45 INFO - 'USER': 'cltbld', 14:32:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:45 INFO - '_': '/tools/buildbot/bin/python'} 14:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:45 INFO - Downloading/unpacking psutil>=3.1.1 14:32:45 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:32:45 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:32:45 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:32:45 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:32:45 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:32:45 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:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:32:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:47 INFO - Installing collected packages: psutil 14:32:47 INFO - Running setup.py install for psutil 14:32:47 INFO - building 'psutil._psutil_linux' extension 14:32:47 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:32:48 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:32:48 INFO - building 'psutil._psutil_posix' extension 14:32:48 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:32:48 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:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:48 INFO - Successfully installed psutil 14:32:48 INFO - Cleaning up... 14:32:48 INFO - Return code: 0 14:32:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:32:48 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:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:48 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:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:48 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 0x201a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, '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': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', '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:32:48 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:32:48 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:32:48 INFO - Using env: {'DISPLAY': ':0', 14:32:48 INFO - 'HOME': '/home/cltbld', 14:32:48 INFO - 'LANG': 'en_US.UTF-8', 14:32:48 INFO - 'LANGUAGE': 'en_US:en', 14:32:48 INFO - 'LOGNAME': 'cltbld', 14:32:48 INFO - 'MAIL': '/var/mail/cltbld', 14:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:48 INFO - 'MOZ_NO_REMOTE': '1', 14:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:48 INFO - 'NO_EM_RESTART': '1', 14:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:48 INFO - 'PWD': '/builds/slave/test', 14:32:48 INFO - 'SHELL': '/bin/bash', 14:32:48 INFO - 'SHLVL': '1', 14:32:48 INFO - 'TERM': 'linux', 14:32:48 INFO - 'TMOUT': '86400', 14:32:48 INFO - 'USER': 'cltbld', 14:32:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:48 INFO - '_': '/tools/buildbot/bin/python'} 14:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:32:50 INFO - Installing collected packages: mozsystemmonitor 14:32:50 INFO - Running setup.py install for mozsystemmonitor 14:32:50 INFO - Successfully installed mozsystemmonitor 14:32:50 INFO - Cleaning up... 14:32:50 INFO - Return code: 0 14:32:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, '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': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', '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:32:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:32:50 INFO - Using env: {'DISPLAY': ':0', 14:32:50 INFO - 'HOME': '/home/cltbld', 14:32:50 INFO - 'LANG': 'en_US.UTF-8', 14:32:50 INFO - 'LANGUAGE': 'en_US:en', 14:32:50 INFO - 'LOGNAME': 'cltbld', 14:32:50 INFO - 'MAIL': '/var/mail/cltbld', 14:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:50 INFO - 'MOZ_NO_REMOTE': '1', 14:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:50 INFO - 'NO_EM_RESTART': '1', 14:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:50 INFO - 'PWD': '/builds/slave/test', 14:32:50 INFO - 'SHELL': '/bin/bash', 14:32:50 INFO - 'SHLVL': '1', 14:32:50 INFO - 'TERM': 'linux', 14:32:50 INFO - 'TMOUT': '86400', 14:32:50 INFO - 'USER': 'cltbld', 14:32:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:50 INFO - '_': '/tools/buildbot/bin/python'} 14:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:51 INFO - Downloading/unpacking jsonschema==2.5.1 14:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:32:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:53 INFO - Downloading functools32-3.2.3-2.tar.gz 14:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:32:53 INFO - warning: no files found matching '*.txt' 14:32:53 INFO - no previously-included directories found matching 'build' 14:32:53 INFO - no previously-included directories found matching 'dist' 14:32:53 INFO - no previously-included directories found matching '.git*' 14:32:53 INFO - Installing collected packages: jsonschema, functools32 14:32:53 INFO - Running setup.py install for functools32 14:32:53 INFO - warning: no files found matching '*.txt' 14:32:53 INFO - no previously-included directories found matching 'build' 14:32:53 INFO - no previously-included directories found matching 'dist' 14:32:53 INFO - no previously-included directories found matching '.git*' 14:32:53 INFO - Successfully installed jsonschema functools32 14:32:53 INFO - Cleaning up... 14:32:53 INFO - Return code: 0 14:32:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:32:53 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:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:53 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:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:53 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 0x201a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, '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': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', '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:32:53 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:32:53 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:32:53 INFO - Using env: {'DISPLAY': ':0', 14:32:53 INFO - 'HOME': '/home/cltbld', 14:32:53 INFO - 'LANG': 'en_US.UTF-8', 14:32:53 INFO - 'LANGUAGE': 'en_US:en', 14:32:53 INFO - 'LOGNAME': 'cltbld', 14:32:53 INFO - 'MAIL': '/var/mail/cltbld', 14:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:53 INFO - 'MOZ_NO_REMOTE': '1', 14:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:53 INFO - 'NO_EM_RESTART': '1', 14:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:53 INFO - 'PWD': '/builds/slave/test', 14:32:53 INFO - 'SHELL': '/bin/bash', 14:32:53 INFO - 'SHLVL': '1', 14:32:53 INFO - 'TERM': 'linux', 14:32:53 INFO - 'TMOUT': '86400', 14:32:53 INFO - 'USER': 'cltbld', 14:32:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:53 INFO - '_': '/tools/buildbot/bin/python'} 14:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:32:53 INFO - Cleaning up... 14:32:53 INFO - Return code: 0 14:32:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:32:53 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:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:53 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:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:53 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 0x201a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, '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': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', '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:32:53 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:32:53 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:32:53 INFO - Using env: {'DISPLAY': ':0', 14:32:53 INFO - 'HOME': '/home/cltbld', 14:32:53 INFO - 'LANG': 'en_US.UTF-8', 14:32:53 INFO - 'LANGUAGE': 'en_US:en', 14:32:53 INFO - 'LOGNAME': 'cltbld', 14:32:53 INFO - 'MAIL': '/var/mail/cltbld', 14:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:53 INFO - 'MOZ_NO_REMOTE': '1', 14:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:53 INFO - 'NO_EM_RESTART': '1', 14:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:53 INFO - 'PWD': '/builds/slave/test', 14:32:53 INFO - 'SHELL': '/bin/bash', 14:32:53 INFO - 'SHLVL': '1', 14:32:53 INFO - 'TERM': 'linux', 14:32:53 INFO - 'TMOUT': '86400', 14:32:53 INFO - 'USER': 'cltbld', 14:32:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:53 INFO - '_': '/tools/buildbot/bin/python'} 14:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:55 INFO - Downloading blobuploader-1.2.4.tar.gz 14:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:32:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:32:56 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:32:56 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:32:56 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:32:56 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:32:56 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:32:56 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:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:32:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:32:56 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:32:56 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:32:56 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:32:56 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:32:56 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:32:56 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:32:56 INFO - Downloading docopt-0.6.1.tar.gz 14:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:32:56 INFO - Installing collected packages: blobuploader, requests, docopt 14:32:56 INFO - Running setup.py install for blobuploader 14:32:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:32:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:32:56 INFO - Running setup.py install for requests 14:32:57 INFO - Running setup.py install for docopt 14:32:57 INFO - Successfully installed blobuploader requests docopt 14:32:57 INFO - Cleaning up... 14:32:57 INFO - Return code: 0 14:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:57 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:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:57 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:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:57 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 0x201a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, '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': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', '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:32:57 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:32:57 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:32:57 INFO - Using env: {'DISPLAY': ':0', 14:32:57 INFO - 'HOME': '/home/cltbld', 14:32:57 INFO - 'LANG': 'en_US.UTF-8', 14:32:57 INFO - 'LANGUAGE': 'en_US:en', 14:32:57 INFO - 'LOGNAME': 'cltbld', 14:32:57 INFO - 'MAIL': '/var/mail/cltbld', 14:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:57 INFO - 'MOZ_NO_REMOTE': '1', 14:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:57 INFO - 'NO_EM_RESTART': '1', 14:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:57 INFO - 'PWD': '/builds/slave/test', 14:32:57 INFO - 'SHELL': '/bin/bash', 14:32:57 INFO - 'SHLVL': '1', 14:32:57 INFO - 'TERM': 'linux', 14:32:57 INFO - 'TMOUT': '86400', 14:32:57 INFO - 'USER': 'cltbld', 14:32:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:57 INFO - '_': '/tools/buildbot/bin/python'} 14:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:57 INFO - Running setup.py (path:/tmp/pip-ckaEdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:57 INFO - Running setup.py (path:/tmp/pip-ym6pAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:57 INFO - Running setup.py (path:/tmp/pip-PScqt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:57 INFO - Running setup.py (path:/tmp/pip-jbFoax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:57 INFO - Running setup.py (path:/tmp/pip-H16YYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:58 INFO - Running setup.py (path:/tmp/pip-Fes4vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:58 INFO - Running setup.py (path:/tmp/pip-FfA20T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:58 INFO - Running setup.py (path:/tmp/pip-3O1FhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:58 INFO - Running setup.py (path:/tmp/pip-4l9gLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:58 INFO - Running setup.py (path:/tmp/pip-gxqJO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:58 INFO - Running setup.py (path:/tmp/pip-sw5TjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:58 INFO - Running setup.py (path:/tmp/pip-d1yOxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:58 INFO - Running setup.py (path:/tmp/pip-6Jzr40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:58 INFO - Running setup.py (path:/tmp/pip-fpviiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:58 INFO - Running setup.py (path:/tmp/pip-oIbVKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:58 INFO - Running setup.py (path:/tmp/pip-QCpGOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:58 INFO - Running setup.py (path:/tmp/pip-6AX5wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:32:58 INFO - Running setup.py install for manifestparser 14:32:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:32:59 INFO - Running setup.py install for mozcrash 14:32:59 INFO - Running setup.py install for mozdebug 14:32:59 INFO - Running setup.py install for mozdevice 14:32:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:32:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:32:59 INFO - Running setup.py install for mozfile 14:32:59 INFO - Running setup.py install for mozhttpd 14:32:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:32:59 INFO - Running setup.py install for mozinfo 14:32:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:32:59 INFO - Running setup.py install for mozInstall 14:32:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:32:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:32:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:32:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:32:59 INFO - Running setup.py install for mozleak 14:32:59 INFO - Running setup.py install for mozlog 14:32:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:32:59 INFO - Running setup.py install for moznetwork 14:33:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:33:00 INFO - Running setup.py install for mozprocess 14:33:00 INFO - Running setup.py install for mozprofile 14:33:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:33:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:33:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:33:00 INFO - Running setup.py install for mozrunner 14:33:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:33:00 INFO - Running setup.py install for mozscreenshot 14:33:00 INFO - Running setup.py install for moztest 14:33:00 INFO - Running setup.py install for mozversion 14:33:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:33:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:33:00 INFO - Cleaning up... 14:33:00 INFO - Return code: 0 14:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:00 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:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 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:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 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 0x201a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, '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': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', '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:33:00 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:33:00 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:33:00 INFO - Using env: {'DISPLAY': ':0', 14:33:00 INFO - 'HOME': '/home/cltbld', 14:33:00 INFO - 'LANG': 'en_US.UTF-8', 14:33:00 INFO - 'LANGUAGE': 'en_US:en', 14:33:00 INFO - 'LOGNAME': 'cltbld', 14:33:00 INFO - 'MAIL': '/var/mail/cltbld', 14:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:00 INFO - 'MOZ_NO_REMOTE': '1', 14:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:00 INFO - 'NO_EM_RESTART': '1', 14:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:00 INFO - 'PWD': '/builds/slave/test', 14:33:00 INFO - 'SHELL': '/bin/bash', 14:33:00 INFO - 'SHLVL': '1', 14:33:00 INFO - 'TERM': 'linux', 14:33:00 INFO - 'TMOUT': '86400', 14:33:00 INFO - 'USER': 'cltbld', 14:33:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:00 INFO - '_': '/tools/buildbot/bin/python'} 14:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:00 INFO - Running setup.py (path:/tmp/pip-0YvvFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:01 INFO - Running setup.py (path:/tmp/pip-75qhX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:01 INFO - Running setup.py (path:/tmp/pip-HvtNKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:01 INFO - Running setup.py (path:/tmp/pip-UInncT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:01 INFO - Running setup.py (path:/tmp/pip-WEJqP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:01 INFO - Running setup.py (path:/tmp/pip-8J3HXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:01 INFO - Running setup.py (path:/tmp/pip-Oou4vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:01 INFO - Running setup.py (path:/tmp/pip-n2pmTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:01 INFO - Running setup.py (path:/tmp/pip-ZWcwtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:01 INFO - Running setup.py (path:/tmp/pip-lIzDl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:01 INFO - Running setup.py (path:/tmp/pip-Vo5uM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:01 INFO - Running setup.py (path:/tmp/pip-F8yG1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:01 INFO - Running setup.py (path:/tmp/pip-xnyepY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:01 INFO - Running setup.py (path:/tmp/pip-NmhALI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:01 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:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:01 INFO - Running setup.py (path:/tmp/pip-z5etOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:02 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:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:02 INFO - Running setup.py (path:/tmp/pip-g_qsR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:02 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:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:02 INFO - Running setup.py (path:/tmp/pip-JvwN9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:02 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:33:02 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:33:02 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:33:02 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:33:02 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:33:02 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:33:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:04 INFO - Downloading blessings-1.6.tar.gz 14:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:33:04 INFO - Installing collected packages: blessings 14:33:04 INFO - Running setup.py install for blessings 14:33:04 INFO - Successfully installed blessings 14:33:04 INFO - Cleaning up... 14:33:04 INFO - Return code: 0 14:33:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:33:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:04 INFO - Reading from file tmpfile_stdout 14:33:04 INFO - Current package versions: 14:33:04 INFO - argparse == 1.2.1 14:33:04 INFO - blessings == 1.6 14:33:04 INFO - blobuploader == 1.2.4 14:33:04 INFO - docopt == 0.6.1 14:33:04 INFO - functools32 == 3.2.3-2 14:33:04 INFO - jsonschema == 2.5.1 14:33:04 INFO - manifestparser == 1.1 14:33:04 INFO - mozInstall == 1.12 14:33:04 INFO - mozcrash == 1.0 14:33:04 INFO - mozdebug == 0.1 14:33:04 INFO - mozdevice == 0.49 14:33:04 INFO - mozfile == 1.2 14:33:04 INFO - mozhttpd == 0.7 14:33:04 INFO - mozinfo == 0.9 14:33:04 INFO - mozleak == 0.1 14:33:04 INFO - mozlog == 3.4 14:33:04 INFO - moznetwork == 0.27 14:33:04 INFO - mozprocess == 0.23 14:33:04 INFO - mozprofile == 0.28 14:33:04 INFO - mozrunner == 6.13 14:33:04 INFO - mozscreenshot == 0.1 14:33:04 INFO - mozsystemmonitor == 0.3 14:33:04 INFO - moztest == 0.8 14:33:04 INFO - mozversion == 1.4 14:33:04 INFO - psutil == 3.1.1 14:33:04 INFO - requests == 1.2.3 14:33:04 INFO - wsgiref == 0.1.2 14:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:04 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:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:04 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:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:04 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 0x201a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, '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': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', '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:33:04 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:33:04 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:33:04 INFO - Using env: {'DISPLAY': ':0', 14:33:04 INFO - 'HOME': '/home/cltbld', 14:33:04 INFO - 'LANG': 'en_US.UTF-8', 14:33:04 INFO - 'LANGUAGE': 'en_US:en', 14:33:04 INFO - 'LOGNAME': 'cltbld', 14:33:04 INFO - 'MAIL': '/var/mail/cltbld', 14:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:04 INFO - 'MOZ_NO_REMOTE': '1', 14:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:04 INFO - 'NO_EM_RESTART': '1', 14:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:04 INFO - 'PWD': '/builds/slave/test', 14:33:04 INFO - 'SHELL': '/bin/bash', 14:33:04 INFO - 'SHLVL': '1', 14:33:04 INFO - 'TERM': 'linux', 14:33:04 INFO - 'TMOUT': '86400', 14:33:04 INFO - 'USER': 'cltbld', 14:33:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:04 INFO - '_': '/tools/buildbot/bin/python'} 14:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:04 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:33:04 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:33:04 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:33:04 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:33:04 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:33:04 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:33:04 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:33:04 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:33:04 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:33:04 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:33:04 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:33:04 INFO - Cleaning up... 14:33:04 INFO - Return code: 0 14:33:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:33:04 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:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:04 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:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:04 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 0x201a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, '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': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', '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:33:04 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:33:04 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:33:04 INFO - Using env: {'DISPLAY': ':0', 14:33:04 INFO - 'HOME': '/home/cltbld', 14:33:04 INFO - 'LANG': 'en_US.UTF-8', 14:33:04 INFO - 'LANGUAGE': 'en_US:en', 14:33:04 INFO - 'LOGNAME': 'cltbld', 14:33:04 INFO - 'MAIL': '/var/mail/cltbld', 14:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:04 INFO - 'MOZ_NO_REMOTE': '1', 14:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:04 INFO - 'NO_EM_RESTART': '1', 14:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:04 INFO - 'PWD': '/builds/slave/test', 14:33:04 INFO - 'SHELL': '/bin/bash', 14:33:04 INFO - 'SHLVL': '1', 14:33:04 INFO - 'TERM': 'linux', 14:33:04 INFO - 'TMOUT': '86400', 14:33:04 INFO - 'USER': 'cltbld', 14:33:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:04 INFO - '_': '/tools/buildbot/bin/python'} 14:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:33:05 INFO - Cleaning up... 14:33:05 INFO - Return code: 0 14:33:05 INFO - Running post-action listener: _resource_record_post_action 14:33:05 INFO - Running post-action listener: _start_resource_monitoring 14:33:05 INFO - Starting resource monitoring. 14:33:05 INFO - [mozharness: 2017-01-05 22:33:05.167051Z] Finished create-virtualenv step (success) 14:33:05 INFO - [mozharness: 2017-01-05 22:33:05.167520Z] Running install step. 14:33:05 INFO - Running pre-action listener: _resource_record_pre_action 14:33:05 INFO - Running main action method: install 14:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:05 INFO - Reading from file tmpfile_stdout 14:33:05 INFO - Detecting whether we're running mozinstall >=1.0... 14:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:33:05 INFO - Reading from file tmpfile_stdout 14:33:05 INFO - Output received: 14:33:05 INFO - Usage: mozinstall [options] installer 14:33:05 INFO - Options: 14:33:05 INFO - -h, --help show this help message and exit 14:33:05 INFO - -d DEST, --destination=DEST 14:33:05 INFO - Directory to install application into. [default: 14:33:05 INFO - "/builds/slave/test"] 14:33:05 INFO - --app=APP Application being installed. [default: firefox] 14:33:05 INFO - mkdir: /builds/slave/test/build/application 14:33:05 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:33:05 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:33:22 INFO - Reading from file tmpfile_stdout 14:33:22 INFO - Output received: 14:33:22 INFO - /builds/slave/test/build/application/firefox/firefox 14:33:22 INFO - Running post-action listener: _resource_record_post_action 14:33:22 INFO - [mozharness: 2017-01-05 22:33:22.800295Z] Finished install step (success) 14:33:22 INFO - [mozharness: 2017-01-05 22:33:22.800568Z] Running run-tests step. 14:33:22 INFO - Running pre-action listener: _resource_record_pre_action 14:33:22 INFO - Running main action method: run_tests 14:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:33:22 INFO - Python 2.7.3 14:33:22 INFO - Return code: 0 14:33:22 INFO - grabbing minidump binary from tooltool 14:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:22 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 0x2389820>, '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 0x238a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:33:22 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:33:22 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:33:22 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:33:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:33:22 INFO - Return code: 0 14:33:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:33:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:33:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:33:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:33:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:33:22 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/1483648504/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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:33:22 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/1483648504/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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:33:22 INFO - Using env: {'DISPLAY': ':0', 14:33:22 INFO - 'HOME': '/home/cltbld', 14:33:22 INFO - 'LANG': 'en_US.UTF-8', 14:33:22 INFO - 'LANGUAGE': 'en_US:en', 14:33:22 INFO - 'LOGNAME': 'cltbld', 14:33:22 INFO - 'MAIL': '/var/mail/cltbld', 14:33:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:33:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:22 INFO - 'MOZ_NO_REMOTE': '1', 14:33:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:33:22 INFO - 'NO_EM_RESTART': '1', 14:33:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:22 INFO - 'PWD': '/builds/slave/test', 14:33:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:33:22 INFO - 'SHELL': '/bin/bash', 14:33:22 INFO - 'SHLVL': '1', 14:33:22 INFO - 'TERM': 'linux', 14:33:22 INFO - 'TMOUT': '86400', 14:33:22 INFO - 'USER': 'cltbld', 14:33:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1483655549.434659-1554256573', 14:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:22 INFO - '_': '/tools/buildbot/bin/python'} 14:33:22 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/1483648504/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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:33:23 INFO - mozversion application_buildid: 20170105123504 14:33:23 INFO - mozversion application_changeset: c484c1e7eeb61f4abd6d9e2352eacd52b1a47cbf 14:33:23 INFO - mozversion application_display_name: Nightly 14:33:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:33:23 INFO - mozversion application_name: Firefox 14:33:23 INFO - mozversion application_remotingname: firefox 14:33:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:33:23 INFO - mozversion application_vendor: Mozilla 14:33:23 INFO - mozversion application_version: 53.0a1 14:33:23 INFO - mozversion platform_buildid: 20170105123504 14:33:23 INFO - mozversion platform_changeset: c484c1e7eeb61f4abd6d9e2352eacd52b1a47cbf 14:33:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:33:23 INFO - mozversion platform_version: 53.0a1 14:33:23 INFO - using testdate: 1483655603 14:33:23 INFO - actual date: 1483655603 14:33:23 INFO - starting webserver on 'localhost:36475' 14:33:23 INFO - SUITE-START | Running 2 tests 14:33:23 INFO - TEST-START | dromaeo_css 14:33:23 INFO - operating with platform_type : linux_ 14:33:23 INFO - Initialising browser for dromaeo_css test... 14:33:23 INFO - TEST-INFO | started process 11186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjepNOj/profile http://localhost:36475/getInfo.html) 14:33:23 INFO - PROCESS | 11186 | 1483655603511 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:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 14:33:27 INFO - PROCESS | 11186 | __metrics Screen width/height:1600/1200 14:33:27 INFO - PROCESS | 11186 | colorDepth:24 14:33:27 INFO - PROCESS | 11186 | Browser inner width/height: 1024/697 14:33:27 INFO - PROCESS | 11186 | __metrics 14:33:28 ERROR - PROCESS | 11186 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 14:33:29 INFO - TEST-INFO | 11186: exit 0 14:33:29 INFO - Browser initialized. 14:33:29 INFO - Running cycle 1/1 for dromaeo_css test... 14:33:29 INFO - TEST-INFO | started process 11308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjepNOj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:41 INFO - PROCESS | 11308 | RSS: Main: 154873856 14:33:41 INFO - PROCESS | 11308 | 14:34:30 INFO - PROCESS | 11308 | 1483655670897 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:36:40 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:36475/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36475/tests/dromaeo/cssquery-ext.html) 14:36:42 INFO - PROCESS | 11308 | RSS: Main: 164392960 14:36:42 INFO - PROCESS | 11308 | 14:38:29 INFO - PROCESS | 11308 | ************************* 14:38:29 INFO - PROCESS | 11308 | A coding exception was thrown and uncaught in a Task. 14:38:29 INFO - PROCESS | 11308 | 14:38:29 INFO - PROCESS | 11308 | Full message: ReferenceError: fetch is not defined 14:38:29 INFO - PROCESS | 11308 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 14:38:29 INFO - PROCESS | 11308 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 14:38:29 INFO - PROCESS | 11308 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 14:38:29 INFO - PROCESS | 11308 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:38:29 INFO - PROCESS | 11308 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:38:29 INFO - PROCESS | 11308 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:38:29 INFO - PROCESS | 11308 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 14:38:29 INFO - PROCESS | 11308 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:38:29 INFO - PROCESS | 11308 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:38:29 INFO - PROCESS | 11308 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:38:29 INFO - PROCESS | 11308 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 14:38:29 INFO - PROCESS | 11308 | 14:38:29 INFO - PROCESS | 11308 | ************************* 14:39:44 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:36475/tests/dromaeo/cssquery-ext.html (next: http://localhost:36475/tests/dromaeo/cssquery-jquery.html) 14:39:45 INFO - PROCESS | 11308 | RSS: Main: 161443840 14:39:45 INFO - PROCESS | 11308 | 14:42:47 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:36475/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36475/tests/dromaeo/cssquery-mootools.html) 14:42:47 INFO - PROCESS | 11308 | RSS: Main: 166703104 14:42:47 INFO - PROCESS | 11308 | 14:45:49 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:36475/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36475/tests/dromaeo/cssquery-prototype.html) 14:45:50 INFO - PROCESS | 11308 | RSS: Main: 161165312 14:45:50 INFO - PROCESS | 11308 | 14:48:53 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:36475/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36475/tests/dromaeo/cssquery-yui.html) 14:48:53 INFO - PROCESS | 11308 | RSS: Main: 165191680 14:48:53 INFO - PROCESS | 11308 | 14:51:56 INFO - PROCESS | 11308 | Cycle 1(1): loaded http://localhost:36475/tests/dromaeo/cssquery-yui.html (next: http://localhost:36475/tests/dromaeo/cssquery-dojo.html) 14:51:56 INFO - PROCESS | 11308 | RSS: Main: 165203968 14:51:56 INFO - PROCESS | 11308 | 14:51:56 INFO - PROCESS | 11308 | __start_tp_report 14:51:56 INFO - PROCESS | 11308 | _x_x_mozilla_page_load 14:51:56 INFO - PROCESS | 11308 | _x_x_mozilla_page_load_details 14:51:56 INFO - PROCESS | 11308 | |i|pagename|runs| 14:51:56 INFO - PROCESS | 11308 | |0;dojo.html;3119.0330997390806;3137.6548579656246;3156.1005113542647;3165.8258795766224;3166.430042592334;5297.152455607104;5346.331708536433;5395.217693434454;5399.3755011180265;5412.07994640911;5377.5966802489775;5446.019716451037;5447.073997420438;5455;5516.503514683678;4761.928571071437;4797.832075877345;4822.300766388871;4907.067657145149;4924.901501969958;4838.516148385169;4925.113479573675;4958.776855041532;4960.429550601672;4966.751662416883;4764.118638051971;4922.778474968635;4936.728479933602;4961.627877909171;5036.6222533309965;4713.5993440557595;4725.810967561293;4761.095391875532;4821.397325334333;4867.17258066126;4753.049390121955;4776.761161941889;4779.187538118528;4792.185328494164;4804.375431193957;5317.335333083364;5328.92006619901;5337.172738225581;5339.279197308391;5366.06093933564;5631.099024156157;5670.064439367499;5704.058830293038;5741.684207368593;5769.480746732815;5864.530837532987;5869.2369991901205;5876.2067120938555;5880.558958078162;5921.407859214087;5456.427075157091;5480.835574932758;5481.342238931274;5486;5489.917651235195;5820.447057529528;5827.24245848037;5866.1494083357675;5874.32445268791;5957.225560677084;5664.943350566442;5671.943280567141;5682.943170568242;5735.053716136874;5755.62588431759;5723.656580605177;5736.196932429463;5794.8551286217335;5799.159121927381;5820.650760954356;5666.546676265889;5707.942920570824;5730.484256416942;5747.741351639186;5752.252207213036;5809.157672137517;5812.796552120655;5816.82549523515;5818.359980402152;5862.091375836752;4317.9136417271475;4342.913141737147;4352.934705979413;4352.956470435255;4395.318725597537;3795.8481660733814;3837.9232415351535;3842.4044273137706;3900.5904380039688;3902.0635047588944;5515.172724091419;5580.888382232332;5583.664980101125;5626.690532020778;5633.887322253532;5807.82576522705;5809.099589563624;5843.1235314703135;5864.882702345929;5872.794452194153;5401.0575705668;5509.146082357241;5558.861028474321;5570.832875013756;5591.27313449249;4800.35195248637;4826.251930950708;4840.515948405202;4857.247126695368;4897.534734200245;6110.388961103943;6112.908306375408;6138.7237574309265;6143.508519318533;6153.569250152446;5705.486506214461;5868.882622347614;5887.911681324869;5888.205092312654;5896.705164741831;5972.163897054329;6118.082287656887;6118.253719382578;6140.232470941132;6143.986242269975;5722.942770572241;5758.971205143947;5776.740046697824;5777.39337369587;5800.158976948234;5828.125781132864;5848.795292164754;5882.029465138205;5890.440408161217;5894.38108998549;5554.722263886709;5616;5633.155026745857;5710.371859095413;5716.199732037435;5688.488036076773;5689.345725241485;5700.315962084576;5706.629069110494;5708.315002199763;5640.266765320482;5663.575231857545;5690.174924635988;5696.202531645656;5700.3444603871085;5770.942290577208;5783.710814459176;5790.39200883918;5790.826275211751;5791.652500849962;5609.326880774333;5610.074337734228;5613.045782217115;5629.155626656035;5638.774449021993 14:51:56 INFO - PROCESS | 11308 | |1;ext.html;532.8463611622051;570.2501210907657;585.6954383720463;585.9677717725523;593.1873333533059;43071.78464107679;44295.557044429544;44442.888927776825;49200.50799492004;49508;45720.314195287094;46236.537634623644;46425.30362044564;46440.53559464405;46444.76777616107;9053.36626436148;9133.17801397874;9182.357234993553;9196.540172991357;10248.333858299224;10201.336913100662;10421.166306695446;10463.110635595984;10466.581336746522;10510.789784204311;10464.05823475887;10541.47292635369;10554.894451055468;10567.048965593094;10588.1529477642;10445.947770261138;10598.099161571276;10599.947000265027;10611.681649550526;10617.628383006635;10304.690859274233;10338.896611033868;10343.224258180591;10377;10417.583296668125;40282.39576406356;40393.79803100995;40439.797801011104;40945.79527102375;41023.7948810257;4135.1316223593085;4145.419641250227;4204.264253755611;4260.147970405931;4263;30804.537931931038;30921.690783092105;32007;32212;32467.350652987043;4299.355096735483;4399.010222699899;4419.889502762425;4452.577005184502;4452.888677783081;341015;343007;344153;344203.9999999975;345518;54766;54838.177427338625;54980;55118;55156.44843551513;57763.49074620356;58177.5455613613;58240.12639810406;58375.70812145912;58380;16040.278187481592;16568;16592.83407165937;16602;16620;12049.759004819854;12388.256704597752;12839.807402888964;13122;13156.079074464695;17899.67304250439;17927.193276302336;17965.281388744304;17965.371212007518;18077.457676269732;7061.187963384174;7281.257798852009;7293.52592081513;7346.265373462611;7440.218777028334;937.4469063252714;962.7881865989472;962.8892677342195;965.903699301298;969.8399764038995;30971.225719357197;31219.531707024413;31722.524162137586;31750.682493174772;32083.679163208537;1119.4738472917716;1140.0822338017974;1142.3031950510183;1148.6611449622214;1157.780021795856;16722.665546688997;17011.149442527825;17099.065383450794;17183.65632687339;17287.481375558753;510228;516283;516693;518392;523836;63823;64195;64297;64398;64404;1462.7586448236134;1466.9926650366467;1479.2307999840023;1482.918439485817;1494.6637006673411;30278.243043924078;31625;32177;32188;32416;54488.72755636196;55288.72355638196;55389.89220215492;55390.72304638451;55439;403732;405935;407015;407096;407505;29299;45063.32405013862;45078.32382514199;46087.308690370344;49858.25212621886;47205.527944721485;47416;47562.286565702234;51824.48175518347;52161;41555;43921.78039109784;44567.77716111398;44625.55374446344;45279.54720452753;42775.14449711051;42874.35688464738;44031.11937761291;44405.555944440144;45484.545154549356;41807;42662.36006459968;42950.78524607357;43409.78295108631;43851;36242.27515449729;38884.80557597307;39299.803500982314;39382.803085984386;39590.40614390844;28547.857260713565;28632.284192895346;28869.855650721613;28914.566281506213;29047.642754019846 14:51:56 INFO - PROCESS | 11308 | |2;jquery.html;427.7082207050966;428.19285646556233;429.8216240260293;432.37737657772806;446.34833143610325;19317.227310907565;20280.89859550702;21344.89327553364;21424.678629820566;21558.461038474008;19074.904625476887;20417.693734593955;20571.691424628643;21010.579788404222;21782.45543861404;5803.912941305874;6000;6027.8848413043725;6033.245844269444;6070.726817293233;5790.68151251681;5905.261842269716;5944.10838374243;5950.434708702666;5961.986462301397;5871.911921321183;5890.381509941437;5925.377835327293;5943.583949123563;5948.524118070565;5783.450572195635;5881.264841894763;5912.556558258148;5938.10928360745;5938.346781853993;5234.633575649668;5298.390685071189;5370.731463426813;5374.355077390738;5382.6232163748555;23507.412314692097;24023.759762402326;24211.273661790176;24408.38979025521;24542.754572454225;2799.4401119776126;2809.3117186289287;2827.9010234641687;2828.5588408552003;2842.6020357150014;15167.772483412758;15525.301361438762;15548.61128471786;15772.842271577252;16116;2001.8898960557165;2004.2484068474323;2004.3185316992146;2013.8791672499697;2029.6448121578665;89665.99999999935;90007.54996225043;90420.54789726075;91072.54463727705;94165;11129.777404452028;11364.352168935624;11383.943080284545;11622.360770157553;11691.883081169079;16172.110533920748;16253.918730406273;16305.429309974093;16306;16315.51053468398;8331.50010999342;8626.6980655678;8635.222829945335;8764.430312029697;8798.604062817189;8314.542700151429;8397.118302578141;8531.573421328909;8657.956710216535;8668.8699669505;7163.570185788869;7239.638018099179;7306;7356.558606483521;7362.595057271795;2084.770675225724;2124.7131637229086;2147.194801949269;2170.5116348821703;2189.321310393783;1105.9668209953713;1138.8974992250737;1140.4639819284923;1162.9065688775463;1175.782480241158;19815.900920495304;19911;20048.89975550113;20151.49621259451;20521.17915283372;1137.5392965848844;1137.6814491942268;1137.9943100284445;1140.6977151054978;1171.6485054483792;10970.561177552969;11315.15136364776;11438.313701177956;11786.76426471483;12025.939870300592;623632;627027;628942;638651;650211;108198;108915.45542272239;112424.44392226588;114932;117141.41429292799;1059.232056758859;1091.5360971587045;1109.5728144664201;1118.1334465788916;1133.3653154233655;18028;18156.364527241483;18493.81506184921;18717.344892928682;18784.38159266308;45885.31172032489;46641.76679116583;46960.29559556541;47200.54784386433;48174.75912620555;65097.34902650913;65340.67329663511;66036;67294.66352668205;67426.66286668535;7877.803054923673;7895.7236496722335;8090.271875530995;8845.513496757483;9154.26765858743;10309;13661.86338136606;13703;14022.368993395527;14025.929870350583;11508;11955.820662689892;11977.580784672495;12122.878771212529;12276.631701048982;11915.2255103418;12128.272303661808;12260.38698065111;12296.323702196465;12414.751704966031;12008.159428839897;12048.698782530157;12252;12266.632001039983;12342.382880856101;7731.961340193263;7940.364770818205;8120.269175774209;8181.550014749246;8236.382271329794;11310.20828542027;11467.770644587228;11563.6530904073;11834.408279586158;11915.16593838423 14:51:56 INFO - PROCESS | 11308 | |3;mootools.html;1400.516821696515;1407.2260256858724;1419.03505616181;1427.400491793447;1430.6709456824935;7609.086909570852;7818.648160832762;8119.066307374654;8139.348852091841;8235.752927412172;8302.626381812817;8423.91576084239;8438.113998030196;8442.282405995498;8478.19457151571;2296.5980953333183;2336.649502574619;2338.0180324263765;2341.5785158671433;2348.53029394121;2261.31030035839;2281.315605318406;2316.4787922717423;2352.3178278299274;2355.528894221154;2273.5339255452677;2280.05377768226;2280.4070941555233;2281.0533628544135;2281.133169395627;2108.8523803333774;2126.5645689159755;2130.7549631792385;2131.8081372676534;2133.2746866065613;2254.5603607296584;2274.8407611467205;2289.496310811619;2293.4266433391654;2305.5965206088867;8233.50598964058;8392.412531122824;8424.620892059873;8438.873416898752;8462.492250464991;5239.685618862881;5363.302770639792;5363.9463605363835;5367.946320536823;5380.058489764276;3149.4960806270888;3288.7369010479106;3315.154635567939;3380.830958452092;3382.0868365541414;1342.570377479207;1377.1186440677975;1397.2105760245531;1436.3536408616164;1457.2567990324906;10609.469526523642;10616.097631701316;10661.733456663567;10662.786744265071;10683.946580267128;4442.489113751895;4477.306017567283;4483.887902802456;4490.281554951192;4553.544645535486;9085.04607016267;9107.772305692411;9141.54292285383;9155.313351498664;9180.17378435944;5268.236105764643;5273.709945953009;5282.9170020145775;5320.733963301819;5332.760025798849;4877.146499362598;4911.950880491149;4958.7024778513405;4960.0575890581395;4970.080535101018;3628.872989445357;3739.457778622085;3750.3436898542645;3801.4487899254455;3874.12832112778;1123.224974767408;1148.3970915269551;1162.8023236049892;1190.5535424215918;1206.849143857018;987.2694206287296;995.9900400996042;998.5257002923553;1006.8137394582026;1008.253892119826;5569.721513924287;5594.580406469531;5599.3202039388025;5615.747291371898;5643.209950606918;1008.324422636835;1026.8511065895402;1030.7165529479453;1034.7257976636197;1035.2649618770606;3965.354377933183;4017.9397309040387;4058.573849745734;4060.3300455425115;4088.7751173685137;9700.854487182698;9922.7023189303;10029.448380339152;10040.447775372279;10067.899321006842;9275.90724092764;9338.112879276458;9559.474228917476;9855.408675479493;9940.602375905028;7367.8158046049275;7692.653830577638;7759.612019399007;7843.215678432111;7867.763967080997;5778.56660750437;5939.613925094855;5960.970195148997;6002.159697642246;6005.129256257906;8993.32550058735;9058.864117038118;9223;9241.122093401116;9248.398854074463;9120.452772833385;9184.678536251198;9245.075492450702;9364.531773411438;9373.297002724687;6997.790066298019;7041.225465198721;7065;7083.362497375261;7107.253738357605;7554.433417493819;7605.391568674603;7643.7324693635455;7687.11598166218;7702.460827742004;7001.334873187039;7096.716131354688;7107.715691372287;7118.430525557839;7282.12614486265;6688.899666505104;6788.932110679028;6858.691358888762;6863.691133899087;6894.896576551256;6279.152314437675;6321.620702757849;6406.295307516077;6410.775622853178;6545.8690826184165;4786.641001924939;4806.303086052572;4877.414710234794;4897.853064408074;5052.216906379517;5049.57078648319;5069.239614057921;5148.2020286855595;5236.842894713165;5278 14:51:56 INFO - PROCESS | 11308 | |4;prototype.html;406.8108329626724;407.69830325559093;412.6224504578311;412.87200967700016;418.55423973468237;5186.611004174683;5266.7629956651945;5373;5464.37159726631;5476.26070480485;5272.868178295545;5341;5393.4336894625985;5446;5454.718141236816;4087.8569250076253;4193.391958166064;4222.451081359419;4328.523862375137;4348.695191548469;4200.3699445083175;4211.978940105295;4214.4099826024385;4222.852200172994;4229.281022226229;4194.895127621819;4198.8320467181275;4210.3894935234375;4213.915721685565;4226.9154616907645;4115.300398932189;4125.608067233608;4219.7046206765535;4226.112516371566;4231.1114665920195;3695.316366472211;3711.777293362407;3717.665410113103;3736.40217565191;3737.3272810894027;5295.993761185362;5297.47025297471;5328.893422131536;5333.786648534093;5351.197320401932;4799.952000479985;4882.853514394574;4894.41267047953;4901.460839307673;4903.779329930162;5676.247020195202;5677.318721753375;5686.317641883001;5692.430756924316;5711.571632127607;4126.607972242662;4133.545310015896;4145.316022856225;4149.460570125894;4154.729942553755;5745.787871669354;5782.355378708857;5872.677002764846;5896.705164741746;5934.397712617612;4181.1010632713505;4197.076643138505;4207.158568286355;4217.261979153697;4240.159093407425;4275.230458517434;4294.763787991628;4296.248156572649;4320.416743739618;4320.805563749576;4845;4846.975765121152;4887.70475823907;4931.728754918514;4941.061198372297;5538.6399884007415;5685.204071430003;5708.828735137952;5733.827985160452;5735.254416925856;1418.6027912184604;1436.906601070927;1437.4034775568232;1442.4807069454987;1446.24795106544;939.9097047424955;1000.229823036258;1003.3027046202965;1005.7636455432968;1015.6289009836809;5369.5568516324975;5386.865328366822;5401.756920938567;5430.728463576806;5432.864178395572;5688.402717714663;5701.942980570224;5704.629199102045;5707.487515808314;5767.336756272998;5168.560672342818;5398.865028374244;5405.351357837085;5521.475459831309;5555.916661250004;2978.7787007326892;2982.538556107492;2986.5968094307423;3027.485327494331;3028.107432854466;5632.493075623213;5842.640481722941;5851.941480585225;5906.468417842329;5924.20023296858;5750.827475175752;5769.249997500298;5776.653400795965;5784.82645520635;5819.072126314721;5859;5873.647581145059;5892.616979896378;5899.407160066758;5946.762129514771;5507.642003269774;5663.876046482569;5727.770889164387;5855.238818953509;5857.297124344936;5748.310202775694;5770.422957704364;5779.508741756998;5792.82621521355;5793.565482588739;5837.591368604157;6036.8188954331445;6080.361562035922;6126.632402055891;6147.969260153671;4177.770222637784;4200.306949353445;4213.47331583552;4226.36604509326;4226.4928208615165;5884.235049443716;5886.264216972879;5906.291245050621;5918.881622367442;5940.316863560746;5610.943890561205;5622.381538030895;5690;5690.971545142248;5733.254676891977;5643.238162847963;5679.148127780866;5697.316322041382;5730.942690573208;5771;5479.3972663007835;5639.774409023593;5669.773209071756;5674.177244299471;5690.658560486384;5660;5668.659880407189;5696.715164241688;5699.29021293602;5707.971460142673;5562.3047119110115;5569.6936668482;5576.609637325349;5584.916226256691;5599.57210911215 14:51:56 INFO - PROCESS | 11308 | |5;yui.html;762.3329586611715;782.2881178127905;804.2440106300078;845.3448577352551;857.2627540315327;15659.530214093582;16189.919050404746;16613.252403641836;16817.243224054917;16894.493165205033;15249.695006099872;15317.770233446507;15376.769348459782;15455.845441545582;15529;743.3272888036336;749.3929916767422;763.1376544504702;764.3273918951315;768.1972338905857;764.4075841223068;772.2740623813626;774.7211004038542;776.4099284543731;777.9260970207821;803.4014659078995;810.4488947515687;811.2374368094003;811.2698571285831;813.7436707437168;796.6892911764417;797.0634504457239;797.1510341486298;800.3597122302135;805.3718099882101;583.7460704593473;590.3063899917622;590.8700085981077;590.9940900590982;591.1251348004934;15709.764353534707;16154.919225403797;16294;16300.918495407446;16337.836621633869;14963.102213867203;15097;15237.771433428508;15423.922880385526;15501.534953951399;12833.165844220095;13015;13047.412866421033;13080.149790263602;13244.735105297936;3828.846846126152;3836.3861782114727;3845;3862.5364956205153;3922.1175235572055;76428.23571764323;77440.61279693621;78394.60802696006;78488.60755696186;78854.605726971;11636.709082273012;11716.23844450108;11775.470103845348;11795.602464367465;11927.1650984432;21941.670874936888;21982.670259946113;22190.556188876133;22256.666150007764;22318;7710.267524585155;7881.290683838482;7884.526928384315;7953.363730901629;7964.442489025829;4601.792919318638;4674.182018146878;4679.859604211879;4729.243321068612;4752.500987396343;3596.964030359663;3652.2330310634534;3661.5056967309074;3701.6113308102263;3715.7398982070995;569.829051284613;572.6964708704394;577.053632043449;580.2022219448259;584.33677775724;791.5053091817614;801.8035581282624;802.1016461563087;823.2919689067397;850.3962186847408;10302.793944121076;10316.587336506456;10486.265961382782;10496.16030717556;10650.147988160928;716.7921302822227;717.9856402872018;718.3427164144749;719.3921136639531;731.9487635865438;4880.145974454456;4896.36347274852;5135.6918584885025;5143.408508021551;5195.272661827347;76812;78312.60843695745;79201.60399197967;81075.18924810676;81897.18102818895;69669.30330696628;70772;71982;72662.27337726661;74642;62987.6850615744;64418;64605;65780;67224.99162512567;9650.517474126405;9976.558087459814;10110.69667909964;10115.79768404613;10161.288709790244;41827.7908610455;43155.92110197145;43161.35257971196;43530.78234608807;44313;51741.22388164256;53564;53954.19068713894;54245.72877135589;54869.72565137149;11319.490622922152;11536.192466527598;11954.820677689668;11980.940095299467;12287.44706488228;13509.189448633113;13514.662133446349;13668.293844505235;13837.861621383658;14394.784078239045;12948;13114.73770524565;13336.599902002956;13381.799273011107;13433.731325373243;11737.47181376823;11798.174127810971;12032.96621410137;12054.879451205376;12359.32023738703;12479.25124492497;12709;12787.61637150887;12960;12967.481300747864;10315.986510777935;10327;10696.144308455461;10813.351198928089;10918.94540527324;9983.251256155672;10595.894041059491;10618;10619.415932123808;10639.521221545205 14:51:56 INFO - PROCESS | 11308 | __end_tp_report 14:51:56 INFO - PROCESS | 11308 | __start_cc_report 14:51:56 INFO - PROCESS | 11308 | _x_x_mozilla_cycle_collect,314 14:51:56 INFO - PROCESS | 11308 | __end_cc_report 14:51:56 INFO - PROCESS | 11308 | __startTimestamp1483656716472__endTimestamp 14:51:56 INFO - PROCESS | 11308 | 14:51:56 INFO - PROCESS | 11308 | ------- Summary: start ------- 14:51:56 INFO - PROCESS | 11308 | Number of tests: 6 14:51:56 INFO - PROCESS | 11308 | 14:51:56 INFO - PROCESS | 11308 | [#0] dojo.html Cycles:165 Average:5383.86 Median:5633.89 stddev:647.60 (11.5%) stddev-sans-first:624.74 14:51:56 INFO - PROCESS | 11308 | Values: 3119.0 3137.7 3156.1 3165.8 3166.4 5297.2 5346.3 5395.2 5399.4 5412.1 5377.6 5446.0 5447.1 5455.0 5516.5 4761.9 4797.8 4822.3 4907.1 4924.9 4838.5 4925.1 4958.8 4960.4 4966.8 4764.1 4922.8 4936.7 4961.6 5036.6 4713.6 4725.8 4761.1 4821.4 4867.2 4753.0 4776.8 4779.2 4792.2 4804.4 5317.3 5328.9 5337.2 5339.3 5366.1 5631.1 5670.1 5704.1 5741.7 5769.5 5864.5 5869.2 5876.2 5880.6 5921.4 5456.4 5480.8 5481.3 5486.0 5489.9 5820.4 5827.2 5866.1 5874.3 5957.2 5664.9 5671.9 5682.9 5735.1 5755.6 5723.7 5736.2 5794.9 5799.2 5820.7 5666.5 5707.9 5730.5 5747.7 5752.3 5809.2 5812.8 5816.8 5818.4 5862.1 4317.9 4342.9 4352.9 4353.0 4395.3 3795.8 3837.9 3842.4 3900.6 3902.1 5515.2 5580.9 5583.7 5626.7 5633.9 5807.8 5809.1 5843.1 5864.9 5872.8 5401.1 5509.1 5558.9 5570.8 5591.3 4800.4 4826.3 4840.5 4857.2 4897.5 6110.4 6112.9 6138.7 6143.5 6153.6 5705.5 5868.9 5887.9 5888.2 5896.7 5972.2 6118.1 6118.3 6140.2 6144.0 5722.9 5759.0 5776.7 5777.4 5800.2 5828.1 5848.8 5882.0 5890.4 5894.4 5554.7 5616.0 5633.2 5710.4 5716.2 5688.5 5689.3 5700.3 5706.6 5708.3 5640.3 5663.6 5690.2 5696.2 5700.3 5770.9 5783.7 5790.4 5790.8 5791.7 5609.3 5610.1 5613.0 5629.2 5638.8 14:51:56 INFO - PROCESS | 11308 | 14:51:56 INFO - PROCESS | 11308 | [#1] ext.html Cycles:180 Average:59822.15 Median:40984.80 stddev:113133.49 (276.0%) stddev-sans-first:113363.28 14:51:56 INFO - PROCESS | 11308 | Values: 532.8 570.3 585.7 586.0 593.2 43071.8 44295.6 44442.9 49200.5 49508.0 45720.3 46236.5 46425.3 46440.5 46444.8 9053.4 9133.2 9182.4 9196.5 10248.3 10201.3 10421.2 10463.1 10466.6 10510.8 10464.1 10541.5 10554.9 10567.0 10588.2 10445.9 10598.1 10599.9 10611.7 10617.6 10304.7 10338.9 10343.2 10377.0 10417.6 40282.4 40393.8 40439.8 40945.8 41023.8 4135.1 4145.4 4204.3 4260.1 4263.0 30804.5 30921.7 32007.0 32212.0 32467.4 4299.4 4399.0 4419.9 4452.6 4452.9 341015.0 343007.0 344153.0 344204.0 345518.0 54766.0 54838.2 54980.0 55118.0 55156.4 57763.5 58177.5 58240.1 58375.7 58380.0 16040.3 16568.0 16592.8 16602.0 16620.0 12049.8 12388.3 12839.8 13122.0 13156.1 17899.7 17927.2 17965.3 17965.4 18077.5 7061.2 7281.3 7293.5 7346.3 7440.2 937.4 962.8 962.9 965.9 969.8 30971.2 31219.5 31722.5 31750.7 32083.7 1119.5 1140.1 1142.3 1148.7 1157.8 16722.7 17011.1 17099.1 17183.7 17287.5 510228.0 516283.0 516693.0 518392.0 523836.0 63823.0 64195.0 64297.0 64398.0 64404.0 1462.8 1467.0 1479.2 1482.9 1494.7 30278.2 31625.0 32177.0 32188.0 32416.0 54488.7 55288.7 55389.9 55390.7 55439.0 403732.0 405935.0 407015.0 407096.0 407505.0 29299.0 45063.3 45078.3 46087.3 49858.3 47205.5 47416.0 47562.3 51824.5 52161.0 41555.0 43921.8 44567.8 44625.6 45279.5 42775.1 42874.4 44031.1 44405.6 45484.5 41807.0 42662.4 42950.8 43409.8 43851.0 36242.3 38884.8 39299.8 39382.8 39590.4 28547.9 28632.3 28869.9 28914.6 29047.6 14:51:56 INFO - PROCESS | 11308 | 14:51:56 INFO - PROCESS | 11308 | [#2] jquery.html Cycles:180 Average:34748.80 Median:11852.83 stddev:104365.65 (880.5%) stddev-sans-first:104626.61 14:51:56 INFO - PROCESS | 11308 | Values: 427.7 428.2 429.8 432.4 446.3 19317.2 20280.9 21344.9 21424.7 21558.5 19074.9 20417.7 20571.7 21010.6 21782.5 5803.9 6000.0 6027.9 6033.2 6070.7 5790.7 5905.3 5944.1 5950.4 5962.0 5871.9 5890.4 5925.4 5943.6 5948.5 5783.5 5881.3 5912.6 5938.1 5938.3 5234.6 5298.4 5370.7 5374.4 5382.6 23507.4 24023.8 24211.3 24408.4 24542.8 2799.4 2809.3 2827.9 2828.6 2842.6 15167.8 15525.3 15548.6 15772.8 16116.0 2001.9 2004.2 2004.3 2013.9 2029.6 89666.0 90007.5 90420.5 91072.5 94165.0 11129.8 11364.4 11383.9 11622.4 11691.9 16172.1 16253.9 16305.4 16306.0 16315.5 8331.5 8626.7 8635.2 8764.4 8798.6 8314.5 8397.1 8531.6 8658.0 8668.9 7163.6 7239.6 7306.0 7356.6 7362.6 2084.8 2124.7 2147.2 2170.5 2189.3 1106.0 1138.9 1140.5 1162.9 1175.8 19815.9 19911.0 20048.9 20151.5 20521.2 1137.5 1137.7 1138.0 1140.7 1171.6 10970.6 11315.2 11438.3 11786.8 12025.9 623632.0 627027.0 628942.0 638651.0 650211.0 108198.0 108915.5 112424.4 114932.0 117141.4 1059.2 1091.5 1109.6 1118.1 1133.4 18028.0 18156.4 18493.8 18717.3 18784.4 45885.3 46641.8 46960.3 47200.5 48174.8 65097.3 65340.7 66036.0 67294.7 67426.7 7877.8 7895.7 8090.3 8845.5 9154.3 10309.0 13661.9 13703.0 14022.4 14025.9 11508.0 11955.8 11977.6 12122.9 12276.6 11915.2 12128.3 12260.4 12296.3 12414.8 12008.2 12048.7 12252.0 12266.6 12342.4 7732.0 7940.4 8120.3 8181.6 8236.4 11310.2 11467.8 11563.7 11834.4 11915.2 14:51:56 INFO - PROCESS | 11308 | 14:51:56 INFO - PROCESS | 11308 | [#3] mootools.html Cycles:180 Average:5426.64 Median:5270.97 stddev:2898.68 (55.0%) stddev-sans-first:2891.01 14:51:56 INFO - PROCESS | 11308 | Values: 1400.5 1407.2 1419.0 1427.4 1430.7 7609.1 7818.6 8119.1 8139.3 8235.8 8302.6 8423.9 8438.1 8442.3 8478.2 2296.6 2336.6 2338.0 2341.6 2348.5 2261.3 2281.3 2316.5 2352.3 2355.5 2273.5 2280.1 2280.4 2281.1 2281.1 2108.9 2126.6 2130.8 2131.8 2133.3 2254.6 2274.8 2289.5 2293.4 2305.6 8233.5 8392.4 8424.6 8438.9 8462.5 5239.7 5363.3 5363.9 5367.9 5380.1 3149.5 3288.7 3315.2 3380.8 3382.1 1342.6 1377.1 1397.2 1436.4 1457.3 10609.5 10616.1 10661.7 10662.8 10683.9 4442.5 4477.3 4483.9 4490.3 4553.5 9085.0 9107.8 9141.5 9155.3 9180.2 5268.2 5273.7 5282.9 5320.7 5332.8 4877.1 4912.0 4958.7 4960.1 4970.1 3628.9 3739.5 3750.3 3801.4 3874.1 1123.2 1148.4 1162.8 1190.6 1206.8 987.3 996.0 998.5 1006.8 1008.3 5569.7 5594.6 5599.3 5615.7 5643.2 1008.3 1026.9 1030.7 1034.7 1035.3 3965.4 4017.9 4058.6 4060.3 4088.8 9700.9 9922.7 10029.4 10040.4 10067.9 9275.9 9338.1 9559.5 9855.4 9940.6 7367.8 7692.7 7759.6 7843.2 7867.8 5778.6 5939.6 5961.0 6002.2 6005.1 8993.3 9058.9 9223.0 9241.1 9248.4 9120.5 9184.7 9245.1 9364.5 9373.3 6997.8 7041.2 7065.0 7083.4 7107.3 7554.4 7605.4 7643.7 7687.1 7702.5 7001.3 7096.7 7107.7 7118.4 7282.1 6688.9 6788.9 6858.7 6863.7 6894.9 6279.2 6321.6 6406.3 6410.8 6545.9 4786.6 4806.3 4877.4 4897.9 5052.2 5049.6 5069.2 5148.2 5236.8 5278.0 14:51:56 INFO - PROCESS | 11308 | 14:51:56 INFO - PROCESS | 11308 | [#4] prototype.html Cycles:180 Average:4779.50 Median:5418.04 stddev:1387.97 (25.6%) stddev-sans-first:1352.50 14:51:56 INFO - PROCESS | 11308 | Values: 406.8 407.7 412.6 412.9 418.6 5186.6 5266.8 5373.0 5464.4 5476.3 5272.9 5341.0 5393.4 5446.0 5454.7 4087.9 4193.4 4222.5 4328.5 4348.7 4200.4 4212.0 4214.4 4222.9 4229.3 4194.9 4198.8 4210.4 4213.9 4226.9 4115.3 4125.6 4219.7 4226.1 4231.1 3695.3 3711.8 3717.7 3736.4 3737.3 5296.0 5297.5 5328.9 5333.8 5351.2 4800.0 4882.9 4894.4 4901.5 4903.8 5676.2 5677.3 5686.3 5692.4 5711.6 4126.6 4133.5 4145.3 4149.5 4154.7 5745.8 5782.4 5872.7 5896.7 5934.4 4181.1 4197.1 4207.2 4217.3 4240.2 4275.2 4294.8 4296.2 4320.4 4320.8 4845.0 4847.0 4887.7 4931.7 4941.1 5538.6 5685.2 5708.8 5733.8 5735.3 1418.6 1436.9 1437.4 1442.5 1446.2 939.9 1000.2 1003.3 1005.8 1015.6 5369.6 5386.9 5401.8 5430.7 5432.9 5688.4 5701.9 5704.6 5707.5 5767.3 5168.6 5398.9 5405.4 5521.5 5555.9 2978.8 2982.5 2986.6 3027.5 3028.1 5632.5 5842.6 5851.9 5906.5 5924.2 5750.8 5769.2 5776.7 5784.8 5819.1 5859.0 5873.6 5892.6 5899.4 5946.8 5507.6 5663.9 5727.8 5855.2 5857.3 5748.3 5770.4 5779.5 5792.8 5793.6 5837.6 6036.8 6080.4 6126.6 6148.0 4177.8 4200.3 4213.5 4226.4 4226.5 5884.2 5886.3 5906.3 5918.9 5940.3 5610.9 5622.4 5690.0 5691.0 5733.3 5643.2 5679.1 5697.3 5730.9 5771.0 5479.4 5639.8 5669.8 5674.2 5690.7 5660.0 5668.7 5696.7 5699.3 5708.0 5562.3 5569.7 5576.6 5584.9 5599.6 14:51:56 INFO - PROCESS | 11308 | 14:51:56 INFO - PROCESS | 11308 | [#5] yui.html Cycles:180 Average:17732.00 Median:43921.89 stddev:22678.81 (51.6%) stddev-sans-first:22706.63 14:51:56 INFO - PROCESS | 11308 | Values: 762.3 782.3 804.2 845.3 857.3 15659.5 16189.9 16613.3 16817.2 16894.5 15249.7 15317.8 15376.8 15455.8 15529.0 743.3 749.4 763.1 764.3 768.2 764.4 772.3 774.7 776.4 777.9 803.4 810.4 811.2 811.3 813.7 796.7 797.1 797.2 800.4 805.4 583.7 590.3 590.9 591.0 591.1 15709.8 16154.9 16294.0 16300.9 16337.8 14963.1 15097.0 15237.8 15423.9 15501.5 12833.2 13015.0 13047.4 13080.1 13244.7 3828.8 3836.4 3845.0 3862.5 3922.1 76428.2 77440.6 78394.6 78488.6 78854.6 11636.7 11716.2 11775.5 11795.6 11927.2 21941.7 21982.7 22190.6 22256.7 22318.0 7710.3 7881.3 7884.5 7953.4 7964.4 4601.8 4674.2 4679.9 4729.2 4752.5 3597.0 3652.2 3661.5 3701.6 3715.7 569.8 572.7 577.1 580.2 584.3 791.5 801.8 802.1 823.3 850.4 10302.8 10316.6 10486.3 10496.2 10650.1 716.8 718.0 718.3 719.4 731.9 4880.1 4896.4 5135.7 5143.4 5195.3 76812.0 78312.6 79201.6 81075.2 81897.2 69669.3 70772.0 71982.0 72662.3 74642.0 62987.7 64418.0 64605.0 65780.0 67225.0 9650.5 9976.6 10110.7 10115.8 10161.3 41827.8 43155.9 43161.4 43530.8 44313.0 51741.2 53564.0 53954.2 54245.7 54869.7 11319.5 11536.2 11954.8 11980.9 12287.4 13509.2 13514.7 13668.3 13837.9 14394.8 12948.0 13114.7 13336.6 13381.8 13433.7 11737.5 11798.2 12033.0 12054.9 12359.3 12479.3 12709.0 12787.6 12960.0 12967.5 10316.0 10327.0 10696.1 10813.4 10918.9 9983.3 10595.9 10618.0 10619.4 10639.5 14:51:56 INFO - PROCESS | 11308 | -------- Summary: end -------- 14:51:56 INFO - PROCESS | 11308 | 14:51:57 INFO - TEST-INFO | 11308: exit 0 14:51:57 INFO - TEST-OK | dromaeo_css | took 1114202ms 14:51:57 INFO - TEST-START | kraken 14:51:57 INFO - operating with platform_type : linux_ 14:51:57 INFO - Initialising browser for kraken test... 14:51:57 INFO - TEST-INFO | started process 11656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5z83eG/profile http://localhost:36475/getInfo.html) 14:51:57 INFO - PROCESS | 11656 | 1483656717721 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:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 14:52:01 INFO - PROCESS | 11656 | __metrics Screen width/height:1600/1200 14:52:01 INFO - PROCESS | 11656 | colorDepth:24 14:52:01 INFO - PROCESS | 11656 | Browser inner width/height: 1024/697 14:52:01 INFO - PROCESS | 11656 | __metrics 14:52:02 ERROR - PROCESS | 11656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 14:52:03 INFO - TEST-INFO | 11656: exit 0 14:52:03 INFO - Browser initialized. 14:52:03 INFO - Running cycle 1/1 for kraken test... 14:52:03 INFO - TEST-INFO | started process 11779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5z83eG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:15 INFO - PROCESS | 11779 | RSS: Main: 154902528 14:52:15 INFO - PROCESS | 11779 | 14:52:18 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36475/tests/kraken/driver.html?testName=audio-beat-detection) 14:52:18 INFO - PROCESS | 11779 | RSS: Main: 161034240 14:52:18 INFO - PROCESS | 11779 | 14:52:21 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36475/tests/kraken/driver.html?testName=audio-dft) 14:52:22 INFO - PROCESS | 11779 | RSS: Main: 159891456 14:52:22 INFO - PROCESS | 11779 | 14:52:25 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36475/tests/kraken/driver.html?testName=audio-fft) 14:52:25 INFO - PROCESS | 11779 | RSS: Main: 156487680 14:52:25 INFO - PROCESS | 11779 | 14:52:27 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36475/tests/kraken/driver.html?testName=audio-oscillator) 14:52:28 INFO - PROCESS | 11779 | RSS: Main: 157487104 14:52:28 INFO - PROCESS | 11779 | 14:52:30 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36475/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:52:31 INFO - PROCESS | 11779 | RSS: Main: 157376512 14:52:31 INFO - PROCESS | 11779 | 14:52:34 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36475/tests/kraken/driver.html?testName=imaging-darkroom) 14:52:34 INFO - PROCESS | 11779 | RSS: Main: 161771520 14:52:34 INFO - PROCESS | 11779 | 14:52:38 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36475/tests/kraken/driver.html?testName=imaging-desaturate) 14:52:38 INFO - PROCESS | 11779 | RSS: Main: 159809536 14:52:38 INFO - PROCESS | 11779 | 14:52:41 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36475/tests/kraken/driver.html?testName=json-parse-financial) 14:52:42 INFO - PROCESS | 11779 | RSS: Main: 160034816 14:52:42 INFO - PROCESS | 11779 | 14:52:44 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36475/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:52:44 INFO - PROCESS | 11779 | RSS: Main: 160219136 14:52:44 INFO - PROCESS | 11779 | 14:52:46 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36475/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:52:47 INFO - PROCESS | 11779 | RSS: Main: 160423936 14:52:47 INFO - PROCESS | 11779 | 14:52:49 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36475/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:52:49 INFO - PROCESS | 11779 | RSS: Main: 160055296 14:52:49 INFO - PROCESS | 11779 | 14:52:52 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:52:53 INFO - PROCESS | 11779 | RSS: Main: 160034816 14:52:53 INFO - PROCESS | 11779 | 14:52:56 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:52:56 INFO - PROCESS | 11779 | RSS: Main: 160813056 14:52:56 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | Cycle 1(1): loaded http://localhost:36475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36475/tests/kraken/driver.html?testName=ai-astar) 14:52:58 INFO - PROCESS | 11779 | RSS: Main: 162668544 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | __start_tp_report 14:52:58 INFO - PROCESS | 11779 | _x_x_mozilla_page_load 14:52:58 INFO - PROCESS | 11779 | _x_x_mozilla_page_load_details 14:52:58 INFO - PROCESS | 11779 | |i|pagename|runs| 14:52:58 INFO - PROCESS | 11779 | |0;ai-astar;107;112;113;111;113;112;113;112;112;112 14:52:58 INFO - PROCESS | 11779 | |1;audio-beat-detection;147;119;120;165;123;119;117;122;139;122 14:52:58 INFO - PROCESS | 11779 | |2;audio-dft;162;162;164;162;162;165;176;166;163;165 14:52:58 INFO - PROCESS | 11779 | |3;audio-fft;75;76;76;105;76;77;77;76;98;76 14:52:58 INFO - PROCESS | 11779 | |4;audio-oscillator;84;85;104;85;84;84;99;84;88;112 14:52:58 INFO - PROCESS | 11779 | |5;imaging-gaussian-blur;118;118;117;118;118;117;118;117;118;122 14:52:58 INFO - PROCESS | 11779 | |6;imaging-darkroom;149;149;148;148;147;148;147;149;148;148 14:52:58 INFO - PROCESS | 11779 | |7;imaging-desaturate;97;96;96;96;97;96;97;98;98;96 14:52:58 INFO - PROCESS | 11779 | |8;json-parse-financial;55;57;57;57;57;57;58;58;59;57 14:52:58 INFO - PROCESS | 11779 | |9;json-stringify-tinderbox;66;68;67;68;67;70;67;68;67;68 14:52:58 INFO - PROCESS | 11779 | |10;stanford-crypto-aes;88;82;91;85;83;82;81;83;86;87 14:52:58 INFO - PROCESS | 11779 | |11;stanford-crypto-ccm;138;128;130;125;131;130;136;127;174;140 14:52:58 INFO - PROCESS | 11779 | |12;stanford-crypto-pbkdf2;172;177;175;167;172;168;167;170;168;170 14:52:58 INFO - PROCESS | 11779 | |13;stanford-crypto-sha256-iterative;64;63;64;68;63;62;63;62;62;63 14:52:58 INFO - PROCESS | 11779 | __end_tp_report 14:52:58 INFO - PROCESS | 11779 | __start_cc_report 14:52:58 INFO - PROCESS | 11779 | _x_x_mozilla_cycle_collect,720 14:52:58 INFO - PROCESS | 11779 | __end_cc_report 14:52:58 INFO - PROCESS | 11779 | __startTimestamp1483656778735__endTimestamp 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | ------- Summary: start ------- 14:52:58 INFO - PROCESS | 11779 | Number of tests: 14 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:1.77 (1.6%) stddev-sans-first:0.67 14:52:58 INFO - PROCESS | 11779 | Values: 107.0 112.0 113.0 111.0 113.0 112.0 113.0 112.0 112.0 112.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:122.50 stddev:15.91 (13.0%) stddev-sans-first:15.53 14:52:58 INFO - PROCESS | 11779 | Values: 147.0 119.0 120.0 165.0 123.0 119.0 117.0 122.0 139.0 122.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:4.24 (2.6%) stddev-sans-first:4.39 14:52:58 INFO - PROCESS | 11779 | Values: 162.0 162.0 164.0 162.0 162.0 165.0 176.0 166.0 163.0 165.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:10.84 (14.3%) stddev-sans-first:11.26 14:52:58 INFO - PROCESS | 11779 | Values: 75.0 76.0 76.0 105.0 76.0 77.0 77.0 76.0 98.0 76.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.50 stddev:10.28 (12.2%) stddev-sans-first:10.59 14:52:58 INFO - PROCESS | 11779 | Values: 84.0 85.0 104.0 85.0 84.0 84.0 99.0 84.0 88.0 112.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.45 (1.2%) stddev-sans-first:1.54 14:52:58 INFO - PROCESS | 11779 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 122.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 14:52:58 INFO - PROCESS | 11779 | Values: 149.0 149.0 148.0 148.0 147.0 148.0 147.0 149.0 148.0 148.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 14:52:58 INFO - PROCESS | 11779 | Values: 97.0 96.0 96.0 96.0 97.0 96.0 97.0 98.0 98.0 96.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.03 (1.8%) stddev-sans-first:0.73 14:52:58 INFO - PROCESS | 11779 | Values: 55.0 57.0 57.0 57.0 57.0 57.0 58.0 58.0 59.0 57.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:1.07 (1.6%) stddev-sans-first:0.97 14:52:58 INFO - PROCESS | 11779 | Values: 66.0 68.0 67.0 68.0 67.0 70.0 67.0 68.0 67.0 68.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.50 stddev:3.19 (3.7%) stddev-sans-first:3.17 14:52:58 INFO - PROCESS | 11779 | Values: 88.0 82.0 91.0 85.0 83.0 82.0 81.0 83.0 86.0 87.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:133.50 stddev:14.25 (10.7%) stddev-sans-first:15.09 14:52:58 INFO - PROCESS | 11779 | Values: 138.0 128.0 130.0 125.0 131.0 130.0 136.0 127.0 174.0 140.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.00 stddev:3.41 (2.0%) stddev-sans-first:3.57 14:52:58 INFO - PROCESS | 11779 | Values: 172.0 177.0 175.0 167.0 172.0 168.0 167.0 170.0 168.0 170.0 14:52:58 INFO - PROCESS | 11779 | 14:52:58 INFO - PROCESS | 11779 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.87 14:52:58 INFO - PROCESS | 11779 | Values: 64.0 63.0 64.0 68.0 63.0 62.0 63.0 62.0 62.0 63.0 14:52:58 INFO - PROCESS | 11779 | -------- Summary: end -------- 14:52:58 INFO - PROCESS | 11779 | 14:52:59 INFO - TEST-INFO | 11779: exit 0 14:52:59 INFO - TEST-OK | kraken | took 62535ms 14:52:59 INFO - SUITE-END | took 1176s 14:52:59 INFO - Completed test suite (00:19:36) 14:52:59 INFO - javascript benchmark 14:52:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7355.295401224215, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.0330997390806, 3137.6548579656246, 3156.1005113542647, 3165.8258795766224, 3166.430042592334, 5297.152455607104, 5346.331708536433, 5395.217693434454, 5399.3755011180265, 5412.07994640911, 5377.5966802489775, 5446.019716451037, 5447.073997420438, 5455.0, 5516.503514683678, 4761.928571071437, 4797.832075877345, 4822.300766388871, 4907.067657145149, 4924.901501969958, 4838.516148385169, 4925.113479573675, 4958.776855041532, 4960.429550601672, 4966.751662416883, 4764.118638051971, 4922.778474968635, 4936.728479933602, 4961.627877909171, 5036.6222533309965, 4713.5993440557595, 4725.810967561293, 4761.095391875532, 4821.397325334333, 4867.17258066126, 4753.049390121955, 4776.761161941889, 4779.187538118528, 4792.185328494164, 4804.375431193957, 5317.335333083364, 5328.92006619901, 5337.172738225581, 5339.279197308391, 5366.06093933564, 5631.099024156157, 5670.064439367499, 5704.058830293038, 5741.684207368593, 5769.480746732815, 5864.530837532987, 5869.2369991901205, 5876.2067120938555, 5880.558958078162, 5921.407859214087, 5456.427075157091, 5480.835574932758, 5481.342238931274, 5486.0, 5489.917651235195, 5820.447057529528, 5827.24245848037, 5866.1494083357675, 5874.32445268791, 5957.225560677084, 5664.943350566442, 5671.943280567141, 5682.943170568242, 5735.053716136874, 5755.62588431759, 5723.656580605177, 5736.196932429463, 5794.8551286217335, 5799.159121927381, 5820.650760954356, 5666.546676265889, 5707.942920570824, 5730.484256416942, 5747.741351639186, 5752.252207213036, 5809.157672137517, 5812.796552120655, 5816.82549523515, 5818.359980402152, 5862.091375836752, 4317.9136417271475, 4342.913141737147, 4352.934705979413, 4352.956470435255, 4395.318725597537, 3795.8481660733814, 3837.9232415351535, 3842.4044273137706, 3900.5904380039688, 3902.0635047588944, 5515.172724091419, 5580.888382232332, 5583.664980101125, 5626.690532020778, 5633.887322253532, 5807.82576522705, 5809.099589563624, 5843.1235314703135, 5864.882702345929, 5872.794452194153, 5401.0575705668, 5509.146082357241, 5558.861028474321, 5570.832875013756, 5591.27313449249, 4800.35195248637, 4826.251930950708, 4840.515948405202, 4857.247126695368, 4897.534734200245, 6110.388961103943, 6112.908306375408, 6138.7237574309265, 6143.508519318533, 6153.569250152446, 5705.486506214461, 5868.882622347614, 5887.911681324869, 5888.205092312654, 5896.705164741831, 5972.163897054329, 6118.082287656887, 6118.253719382578, 6140.232470941132, 6143.986242269975, 5722.942770572241, 5758.971205143947, 5776.740046697824, 5777.39337369587, 5800.158976948234, 5828.125781132864, 5848.795292164754, 5882.029465138205, 5890.440408161217, 5894.38108998549, 5554.722263886709, 5616.0, 5633.155026745857, 5710.371859095413, 5716.199732037435, 5688.488036076773, 5689.345725241485, 5700.315962084576, 5706.629069110494, 5708.315002199763, 5640.266765320482, 5663.575231857545, 5690.174924635988, 5696.202531645656, 5700.3444603871085, 5770.942290577208, 5783.710814459176, 5790.39200883918, 5790.826275211751, 5791.652500849962, 5609.326880774333, 5610.074337734228, 5613.045782217115, 5629.155626656035, 5638.774449021993], "value": 5337.985829625939, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.8463611622051, 570.2501210907657, 585.6954383720463, 585.9677717725523, 593.1873333533059, 43071.78464107679, 44295.557044429544, 44442.888927776825, 49200.50799492004, 49508.0, 45720.314195287094, 46236.537634623644, 46425.30362044564, 46440.53559464405, 46444.76777616107, 9053.36626436148, 9133.17801397874, 9182.357234993553, 9196.540172991357, 10248.333858299224, 10201.336913100662, 10421.166306695446, 10463.110635595984, 10466.581336746522, 10510.789784204311, 10464.05823475887, 10541.47292635369, 10554.894451055468, 10567.048965593094, 10588.1529477642, 10445.947770261138, 10598.099161571276, 10599.947000265027, 10611.681649550526, 10617.628383006635, 10304.690859274233, 10338.896611033868, 10343.224258180591, 10377.0, 10417.583296668125, 40282.39576406356, 40393.79803100995, 40439.797801011104, 40945.79527102375, 41023.7948810257, 4135.1316223593085, 4145.419641250227, 4204.264253755611, 4260.147970405931, 4263.0, 30804.537931931038, 30921.690783092105, 32007.0, 32212.0, 32467.350652987043, 4299.355096735483, 4399.010222699899, 4419.889502762425, 4452.577005184502, 4452.888677783081, 341015.0, 343007.0, 344153.0, 344203.9999999975, 345518.0, 54766.0, 54838.177427338625, 54980.0, 55118.0, 55156.44843551513, 57763.49074620356, 58177.5455613613, 58240.12639810406, 58375.70812145912, 58380.0, 16040.278187481592, 16568.0, 16592.83407165937, 16602.0, 16620.0, 12049.759004819854, 12388.256704597752, 12839.807402888964, 13122.0, 13156.079074464695, 17899.67304250439, 17927.193276302336, 17965.281388744304, 17965.371212007518, 18077.457676269732, 7061.187963384174, 7281.257798852009, 7293.52592081513, 7346.265373462611, 7440.218777028334, 937.4469063252714, 962.7881865989472, 962.8892677342195, 965.903699301298, 969.8399764038995, 30971.225719357197, 31219.531707024413, 31722.524162137586, 31750.682493174772, 32083.679163208537, 1119.4738472917716, 1140.0822338017974, 1142.3031950510183, 1148.6611449622214, 1157.780021795856, 16722.665546688997, 17011.149442527825, 17099.065383450794, 17183.65632687339, 17287.481375558753, 510228.0, 516283.0, 516693.0, 518392.0, 523836.0, 63823.0, 64195.0, 64297.0, 64398.0, 64404.0, 1462.7586448236134, 1466.9926650366467, 1479.2307999840023, 1482.918439485817, 1494.6637006673411, 30278.243043924078, 31625.0, 32177.0, 32188.0, 32416.0, 54488.72755636196, 55288.72355638196, 55389.89220215492, 55390.72304638451, 55439.0, 403732.0, 405935.0, 407015.0, 407096.0, 407505.0, 29299.0, 45063.32405013862, 45078.32382514199, 46087.308690370344, 49858.25212621886, 47205.527944721485, 47416.0, 47562.286565702234, 51824.48175518347, 52161.0, 41555.0, 43921.78039109784, 44567.77716111398, 44625.55374446344, 45279.54720452753, 42775.14449711051, 42874.35688464738, 44031.11937761291, 44405.555944440144, 45484.545154549356, 41807.0, 42662.36006459968, 42950.78524607357, 43409.78295108631, 43851.0, 36242.27515449729, 38884.80557597307, 39299.803500982314, 39382.803085984386, 39590.40614390844, 28547.857260713565, 28632.284192895346, 28869.855650721613, 28914.566281506213, 29047.642754019846], "value": 21003.79294074883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.7082207050966, 428.19285646556233, 429.8216240260293, 432.37737657772806, 446.34833143610325, 19317.227310907565, 20280.89859550702, 21344.89327553364, 21424.678629820566, 21558.461038474008, 19074.904625476887, 20417.693734593955, 20571.691424628643, 21010.579788404222, 21782.45543861404, 5803.912941305874, 6000.0, 6027.8848413043725, 6033.245844269444, 6070.726817293233, 5790.68151251681, 5905.261842269716, 5944.10838374243, 5950.434708702666, 5961.986462301397, 5871.911921321183, 5890.381509941437, 5925.377835327293, 5943.583949123563, 5948.524118070565, 5783.450572195635, 5881.264841894763, 5912.556558258148, 5938.10928360745, 5938.346781853993, 5234.633575649668, 5298.390685071189, 5370.731463426813, 5374.355077390738, 5382.6232163748555, 23507.412314692097, 24023.759762402326, 24211.273661790176, 24408.38979025521, 24542.754572454225, 2799.4401119776126, 2809.3117186289287, 2827.9010234641687, 2828.5588408552003, 2842.6020357150014, 15167.772483412758, 15525.301361438762, 15548.61128471786, 15772.842271577252, 16116.0, 2001.8898960557165, 2004.2484068474323, 2004.3185316992146, 2013.8791672499697, 2029.6448121578665, 89665.99999999935, 90007.54996225043, 90420.54789726075, 91072.54463727705, 94165.0, 11129.777404452028, 11364.352168935624, 11383.943080284545, 11622.360770157553, 11691.883081169079, 16172.110533920748, 16253.918730406273, 16305.429309974093, 16306.0, 16315.51053468398, 8331.50010999342, 8626.6980655678, 8635.222829945335, 8764.430312029697, 8798.604062817189, 8314.542700151429, 8397.118302578141, 8531.573421328909, 8657.956710216535, 8668.8699669505, 7163.570185788869, 7239.638018099179, 7306.0, 7356.558606483521, 7362.595057271795, 2084.770675225724, 2124.7131637229086, 2147.194801949269, 2170.5116348821703, 2189.321310393783, 1105.9668209953713, 1138.8974992250737, 1140.4639819284923, 1162.9065688775463, 1175.782480241158, 19815.900920495304, 19911.0, 20048.89975550113, 20151.49621259451, 20521.17915283372, 1137.5392965848844, 1137.6814491942268, 1137.9943100284445, 1140.6977151054978, 1171.6485054483792, 10970.561177552969, 11315.15136364776, 11438.313701177956, 11786.76426471483, 12025.939870300592, 623632.0, 627027.0, 628942.0, 638651.0, 650211.0, 108198.0, 108915.45542272239, 112424.44392226588, 114932.0, 117141.41429292799, 1059.232056758859, 1091.5360971587045, 1109.5728144664201, 1118.1334465788916, 1133.3653154233655, 18028.0, 18156.364527241483, 18493.81506184921, 18717.344892928682, 18784.38159266308, 45885.31172032489, 46641.76679116583, 46960.29559556541, 47200.54784386433, 48174.75912620555, 65097.34902650913, 65340.67329663511, 66036.0, 67294.66352668205, 67426.66286668535, 7877.803054923673, 7895.7236496722335, 8090.271875530995, 8845.513496757483, 9154.26765858743, 10309.0, 13661.86338136606, 13703.0, 14022.368993395527, 14025.929870350583, 11508.0, 11955.820662689892, 11977.580784672495, 12122.878771212529, 12276.631701048982, 11915.2255103418, 12128.272303661808, 12260.38698065111, 12296.323702196465, 12414.751704966031, 12008.159428839897, 12048.698782530157, 12252.0, 12266.632001039983, 12342.382880856101, 7731.961340193263, 7940.364770818205, 8120.269175774209, 8181.550014749246, 8236.382271329794, 11310.20828542027, 11467.770644587228, 11563.6530904073, 11834.408279586158, 11915.16593838423], "value": 10066.816590089868, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.516821696515, 1407.2260256858724, 1419.03505616181, 1427.400491793447, 1430.6709456824935, 7609.086909570852, 7818.648160832762, 8119.066307374654, 8139.348852091841, 8235.752927412172, 8302.626381812817, 8423.91576084239, 8438.113998030196, 8442.282405995498, 8478.19457151571, 2296.5980953333183, 2336.649502574619, 2338.0180324263765, 2341.5785158671433, 2348.53029394121, 2261.31030035839, 2281.315605318406, 2316.4787922717423, 2352.3178278299274, 2355.528894221154, 2273.5339255452677, 2280.05377768226, 2280.4070941555233, 2281.0533628544135, 2281.133169395627, 2108.8523803333774, 2126.5645689159755, 2130.7549631792385, 2131.8081372676534, 2133.2746866065613, 2254.5603607296584, 2274.8407611467205, 2289.496310811619, 2293.4266433391654, 2305.5965206088867, 8233.50598964058, 8392.412531122824, 8424.620892059873, 8438.873416898752, 8462.492250464991, 5239.685618862881, 5363.302770639792, 5363.9463605363835, 5367.946320536823, 5380.058489764276, 3149.4960806270888, 3288.7369010479106, 3315.154635567939, 3380.830958452092, 3382.0868365541414, 1342.570377479207, 1377.1186440677975, 1397.2105760245531, 1436.3536408616164, 1457.2567990324906, 10609.469526523642, 10616.097631701316, 10661.733456663567, 10662.786744265071, 10683.946580267128, 4442.489113751895, 4477.306017567283, 4483.887902802456, 4490.281554951192, 4553.544645535486, 9085.04607016267, 9107.772305692411, 9141.54292285383, 9155.313351498664, 9180.17378435944, 5268.236105764643, 5273.709945953009, 5282.9170020145775, 5320.733963301819, 5332.760025798849, 4877.146499362598, 4911.950880491149, 4958.7024778513405, 4960.0575890581395, 4970.080535101018, 3628.872989445357, 3739.457778622085, 3750.3436898542645, 3801.4487899254455, 3874.12832112778, 1123.224974767408, 1148.3970915269551, 1162.8023236049892, 1190.5535424215918, 1206.849143857018, 987.2694206287296, 995.9900400996042, 998.5257002923553, 1006.8137394582026, 1008.253892119826, 5569.721513924287, 5594.580406469531, 5599.3202039388025, 5615.747291371898, 5643.209950606918, 1008.324422636835, 1026.8511065895402, 1030.7165529479453, 1034.7257976636197, 1035.2649618770606, 3965.354377933183, 4017.9397309040387, 4058.573849745734, 4060.3300455425115, 4088.7751173685137, 9700.854487182698, 9922.7023189303, 10029.448380339152, 10040.447775372279, 10067.899321006842, 9275.90724092764, 9338.112879276458, 9559.474228917476, 9855.408675479493, 9940.602375905028, 7367.8158046049275, 7692.653830577638, 7759.612019399007, 7843.215678432111, 7867.763967080997, 5778.56660750437, 5939.613925094855, 5960.970195148997, 6002.159697642246, 6005.129256257906, 8993.32550058735, 9058.864117038118, 9223.0, 9241.122093401116, 9248.398854074463, 9120.452772833385, 9184.678536251198, 9245.075492450702, 9364.531773411438, 9373.297002724687, 6997.790066298019, 7041.225465198721, 7065.0, 7083.362497375261, 7107.253738357605, 7554.433417493819, 7605.391568674603, 7643.7324693635455, 7687.11598166218, 7702.460827742004, 7001.334873187039, 7096.716131354688, 7107.715691372287, 7118.430525557839, 7282.12614486265, 6688.899666505104, 6788.932110679028, 6858.691358888762, 6863.691133899087, 6894.896576551256, 6279.152314437675, 6321.620702757849, 6406.295307516077, 6410.775622853178, 6545.8690826184165, 4786.641001924939, 4806.303086052572, 4877.414710234794, 4897.853064408074, 5052.216906379517, 5049.57078648319, 5069.239614057921, 5148.2020286855595, 5236.842894713165, 5278.0], "value": 4447.389960089763, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.8108329626724, 407.69830325559093, 412.6224504578311, 412.87200967700016, 418.55423973468237, 5186.611004174683, 5266.7629956651945, 5373.0, 5464.37159726631, 5476.26070480485, 5272.868178295545, 5341.0, 5393.4336894625985, 5446.0, 5454.718141236816, 4087.8569250076253, 4193.391958166064, 4222.451081359419, 4328.523862375137, 4348.695191548469, 4200.3699445083175, 4211.978940105295, 4214.4099826024385, 4222.852200172994, 4229.281022226229, 4194.895127621819, 4198.8320467181275, 4210.3894935234375, 4213.915721685565, 4226.9154616907645, 4115.300398932189, 4125.608067233608, 4219.7046206765535, 4226.112516371566, 4231.1114665920195, 3695.316366472211, 3711.777293362407, 3717.665410113103, 3736.40217565191, 3737.3272810894027, 5295.993761185362, 5297.47025297471, 5328.893422131536, 5333.786648534093, 5351.197320401932, 4799.952000479985, 4882.853514394574, 4894.41267047953, 4901.460839307673, 4903.779329930162, 5676.247020195202, 5677.318721753375, 5686.317641883001, 5692.430756924316, 5711.571632127607, 4126.607972242662, 4133.545310015896, 4145.316022856225, 4149.460570125894, 4154.729942553755, 5745.787871669354, 5782.355378708857, 5872.677002764846, 5896.705164741746, 5934.397712617612, 4181.1010632713505, 4197.076643138505, 4207.158568286355, 4217.261979153697, 4240.159093407425, 4275.230458517434, 4294.763787991628, 4296.248156572649, 4320.416743739618, 4320.805563749576, 4845.0, 4846.975765121152, 4887.70475823907, 4931.728754918514, 4941.061198372297, 5538.6399884007415, 5685.204071430003, 5708.828735137952, 5733.827985160452, 5735.254416925856, 1418.6027912184604, 1436.906601070927, 1437.4034775568232, 1442.4807069454987, 1446.24795106544, 939.9097047424955, 1000.229823036258, 1003.3027046202965, 1005.7636455432968, 1015.6289009836809, 5369.5568516324975, 5386.865328366822, 5401.756920938567, 5430.728463576806, 5432.864178395572, 5688.402717714663, 5701.942980570224, 5704.629199102045, 5707.487515808314, 5767.336756272998, 5168.560672342818, 5398.865028374244, 5405.351357837085, 5521.475459831309, 5555.916661250004, 2978.7787007326892, 2982.538556107492, 2986.5968094307423, 3027.485327494331, 3028.107432854466, 5632.493075623213, 5842.640481722941, 5851.941480585225, 5906.468417842329, 5924.20023296858, 5750.827475175752, 5769.249997500298, 5776.653400795965, 5784.82645520635, 5819.072126314721, 5859.0, 5873.647581145059, 5892.616979896378, 5899.407160066758, 5946.762129514771, 5507.642003269774, 5663.876046482569, 5727.770889164387, 5855.238818953509, 5857.297124344936, 5748.310202775694, 5770.422957704364, 5779.508741756998, 5792.82621521355, 5793.565482588739, 5837.591368604157, 6036.8188954331445, 6080.361562035922, 6126.632402055891, 6147.969260153671, 4177.770222637784, 4200.306949353445, 4213.47331583552, 4226.36604509326, 4226.4928208615165, 5884.235049443716, 5886.264216972879, 5906.291245050621, 5918.881622367442, 5940.316863560746, 5610.943890561205, 5622.381538030895, 5690.0, 5690.971545142248, 5733.254676891977, 5643.238162847963, 5679.148127780866, 5697.316322041382, 5730.942690573208, 5771.0, 5479.3972663007835, 5639.774409023593, 5669.773209071756, 5674.177244299471, 5690.658560486384, 5660.0, 5668.659880407189, 5696.715164241688, 5699.29021293602, 5707.971460142673, 5562.3047119110115, 5569.6936668482, 5576.609637325349, 5584.916226256691, 5599.57210911215], "value": 4356.356232128511, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.3329586611715, 782.2881178127905, 804.2440106300078, 845.3448577352551, 857.2627540315327, 15659.530214093582, 16189.919050404746, 16613.252403641836, 16817.243224054917, 16894.493165205033, 15249.695006099872, 15317.770233446507, 15376.769348459782, 15455.845441545582, 15529.0, 743.3272888036336, 749.3929916767422, 763.1376544504702, 764.3273918951315, 768.1972338905857, 764.4075841223068, 772.2740623813626, 774.7211004038542, 776.4099284543731, 777.9260970207821, 803.4014659078995, 810.4488947515687, 811.2374368094003, 811.2698571285831, 813.7436707437168, 796.6892911764417, 797.0634504457239, 797.1510341486298, 800.3597122302135, 805.3718099882101, 583.7460704593473, 590.3063899917622, 590.8700085981077, 590.9940900590982, 591.1251348004934, 15709.764353534707, 16154.919225403797, 16294.0, 16300.918495407446, 16337.836621633869, 14963.102213867203, 15097.0, 15237.771433428508, 15423.922880385526, 15501.534953951399, 12833.165844220095, 13015.0, 13047.412866421033, 13080.149790263602, 13244.735105297936, 3828.846846126152, 3836.3861782114727, 3845.0, 3862.5364956205153, 3922.1175235572055, 76428.23571764323, 77440.61279693621, 78394.60802696006, 78488.60755696186, 78854.605726971, 11636.709082273012, 11716.23844450108, 11775.470103845348, 11795.602464367465, 11927.1650984432, 21941.670874936888, 21982.670259946113, 22190.556188876133, 22256.666150007764, 22318.0, 7710.267524585155, 7881.290683838482, 7884.526928384315, 7953.363730901629, 7964.442489025829, 4601.792919318638, 4674.182018146878, 4679.859604211879, 4729.243321068612, 4752.500987396343, 3596.964030359663, 3652.2330310634534, 3661.5056967309074, 3701.6113308102263, 3715.7398982070995, 569.829051284613, 572.6964708704394, 577.053632043449, 580.2022219448259, 584.33677775724, 791.5053091817614, 801.8035581282624, 802.1016461563087, 823.2919689067397, 850.3962186847408, 10302.793944121076, 10316.587336506456, 10486.265961382782, 10496.16030717556, 10650.147988160928, 716.7921302822227, 717.9856402872018, 718.3427164144749, 719.3921136639531, 731.9487635865438, 4880.145974454456, 4896.36347274852, 5135.6918584885025, 5143.408508021551, 5195.272661827347, 76812.0, 78312.60843695745, 79201.60399197967, 81075.18924810676, 81897.18102818895, 69669.30330696628, 70772.0, 71982.0, 72662.27337726661, 74642.0, 62987.6850615744, 64418.0, 64605.0, 65780.0, 67224.99162512567, 9650.517474126405, 9976.558087459814, 10110.69667909964, 10115.79768404613, 10161.288709790244, 41827.7908610455, 43155.92110197145, 43161.35257971196, 43530.78234608807, 44313.0, 51741.22388164256, 53564.0, 53954.19068713894, 54245.72877135589, 54869.72565137149, 11319.490622922152, 11536.192466527598, 11954.820677689668, 11980.940095299467, 12287.44706488228, 13509.189448633113, 13514.662133446349, 13668.293844505235, 13837.861621383658, 14394.784078239045, 12948.0, 13114.73770524565, 13336.599902002956, 13381.799273011107, 13433.731325373243, 11737.47181376823, 11798.174127810971, 12032.96621410137, 12054.879451205376, 12359.32023738703, 12479.25124492497, 12709.0, 12787.61637150887, 12960.0, 12967.481300747864, 10315.986510777935, 10327.0, 10696.144308455461, 10813.351198928089, 10918.94540527324, 9983.251256155672, 10595.894041059491, 10618.0, 10619.415932123808, 10639.521221545205], "value": 7240.300604619882, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 113.0, 111.0, 113.0, 112.0, 113.0, 112.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 120.0, 165.0, 123.0, 119.0, 117.0, 122.0, 139.0, 122.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 162.0, 162.0, 165.0, 176.0, 166.0, 163.0, 165.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 105.0, 76.0, 77.0, 77.0, 76.0, 98.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 104.0, 85.0, 84.0, 84.0, 99.0, 84.0, 88.0, 112.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 122.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 147.0, 148.0, 147.0, 149.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 98.0, 98.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 58.0, 59.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 68.0, 67.0, 70.0, 67.0, 68.0, 67.0, 68.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 91.0, 85.0, 83.0, 82.0, 81.0, 83.0, 86.0, 87.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 128.0, 130.0, 125.0, 131.0, 130.0, 136.0, 127.0, 174.0, 140.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 177.0, 175.0, 167.0, 172.0, 168.0, 167.0, 170.0, 168.0, 170.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 68.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 63.4, "unit": "score"}]}]} 14:52:59 INFO - Return code: 0 14:53:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:53:00 ERROR - # TBPL SUCCESS # 14:53:00 INFO - Running post-action listener: _resource_record_post_action 14:53:00 INFO - [mozharness: 2017-01-05 22:53:00.043085Z] Finished run-tests step (success) 14:53:00 INFO - Running post-run listener: _resource_record_post_run 14:53:00 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 398286848; Read time: 560; Write time: 706728 14:53:00 INFO - TinderboxPrint: CPU usage
13.5% 14:53:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 560 14:53:00 INFO - TinderboxPrint: I/O write bytes / time
398,286,848 / 706,728 14:53:00 INFO - TinderboxPrint: CPU idle
8,239.9 (86.5%) 14:53:00 INFO - TinderboxPrint: CPU user
1,221.4 (12.8%) 14:53:00 INFO - TinderboxPrint: Swap in / out
0 / 0 14:53:00 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 104939520; Read time: 0; Write time: 224312 14:53:00 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290942976; Read time: 552; Write time: 482340 14:53:00 INFO - Running post-run listener: _upload_blobber_files 14:53:00 INFO - Blob upload gear active. 14:53:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:53:00 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:53:00 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:53:00 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:53:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:02 INFO - (blobuploader) - INFO - Done attempting. 14:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:53:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:07 INFO - (blobuploader) - INFO - Done attempting. 14:53:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:53:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:53:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:08 INFO - (blobuploader) - INFO - Done attempting. 14:53:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:53:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:53:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:09 INFO - (blobuploader) - INFO - Done attempting. 14:53:09 INFO - (blobuploader) - INFO - Iteration through files over. 14:53:09 INFO - Return code: 0 14:53:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:53:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:53:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d8b2552a58edfba98d3571b3b68bdef2684650b425215a640b0dbb7ee60c0650efb5576613426c9826c884e428a702d4b51b44aaa0a513b5378f8a62bcfeb08c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41e8d582aa62ef715d6676303644937be154bfb6d9fab7da512080fd69453f07d8cf5e5955860dfd8e88924b70c325b50c2fcc8faf7e322082998b3722d31041", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6022b2fc4a60023c70d111be373727907cf193d656f15a68ea711ad7af9aac90fbd6b0a110a8a662f38f086cdfd2d8e93f07e1e0a3d0956cf1d9e08027a6edf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8b86982901a54535027ee9104c4ba043096b3460318046f4ee540659f251203781326eee64d6b3178d3f14178535945e0148ebb4ac3255e59fa1b2c46b83e4b"} 14:53:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:53:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:53:09 INFO - Contents: 14:53:09 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d8b2552a58edfba98d3571b3b68bdef2684650b425215a640b0dbb7ee60c0650efb5576613426c9826c884e428a702d4b51b44aaa0a513b5378f8a62bcfeb08c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41e8d582aa62ef715d6676303644937be154bfb6d9fab7da512080fd69453f07d8cf5e5955860dfd8e88924b70c325b50c2fcc8faf7e322082998b3722d31041", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6022b2fc4a60023c70d111be373727907cf193d656f15a68ea711ad7af9aac90fbd6b0a110a8a662f38f086cdfd2d8e93f07e1e0a3d0956cf1d9e08027a6edf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8b86982901a54535027ee9104c4ba043096b3460318046f4ee540659f251203781326eee64d6b3178d3f14178535945e0148ebb4ac3255e59fa1b2c46b83e4b"} 14:53:09 INFO - Running post-run listener: copy_logs_to_upload_dir 14:53:09 INFO - Copying logs to upload dir... 14:53:09 INFO - mkdir: /builds/slave/test/build/upload/logs 14:53:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.168297 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-01-05 14:53:08.911421) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 14:53:08.914868) ========= 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=745a4373a2a16df560f216e000000264-1483655549.434659-1554256573 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/d8b2552a58edfba98d3571b3b68bdef2684650b425215a640b0dbb7ee60c0650efb5576613426c9826c884e428a702d4b51b44aaa0a513b5378f8a62bcfeb08c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41e8d582aa62ef715d6676303644937be154bfb6d9fab7da512080fd69453f07d8cf5e5955860dfd8e88924b70c325b50c2fcc8faf7e322082998b3722d31041", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6022b2fc4a60023c70d111be373727907cf193d656f15a68ea711ad7af9aac90fbd6b0a110a8a662f38f086cdfd2d8e93f07e1e0a3d0956cf1d9e08027a6edf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8b86982901a54535027ee9104c4ba043096b3460318046f4ee540659f251203781326eee64d6b3178d3f14178535945e0148ebb4ac3255e59fa1b2c46b83e4b"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483648504/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/d8b2552a58edfba98d3571b3b68bdef2684650b425215a640b0dbb7ee60c0650efb5576613426c9826c884e428a702d4b51b44aaa0a513b5378f8a62bcfeb08c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41e8d582aa62ef715d6676303644937be154bfb6d9fab7da512080fd69453f07d8cf5e5955860dfd8e88924b70c325b50c2fcc8faf7e322082998b3722d31041", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6022b2fc4a60023c70d111be373727907cf193d656f15a68ea711ad7af9aac90fbd6b0a110a8a662f38f086cdfd2d8e93f07e1e0a3d0956cf1d9e08027a6edf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8b86982901a54535027ee9104c4ba043096b3460318046f4ee540659f251203781326eee64d6b3178d3f14178535945e0148ebb4ac3255e59fa1b2c46b83e4b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 14:53:08.939975) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:53:08.940276) ========= 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=745a4373a2a16df560f216e000000264-1483655549.434659-1554256573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:53:09.025525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 14:53:09.025864) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 14:53:09.026147) ========= ========= Total master_lag: 0.17 =========