builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1482749046.41 results: success (0) buildid: 20161226024328 builduid: f403e40d105842f29edd674e5bcd7c6b revision: 447fbe42c556b91ebd0fe73ee74e699b8fd8f5fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:06.409489) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:06.410139) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:06.410484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:06.505097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:06.505463) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-26 02:44:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.2M=0s 2016-12-26 02:44:06 (24.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161308 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:06.701026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:06.701364) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.087700 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:06.816913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:06.817275) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 447fbe42c556b91ebd0fe73ee74e699b8fd8f5fa --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 447fbe42c556b91ebd0fe73ee74e699b8fd8f5fa --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=56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-26 02:44:06,974 truncating revision to first 12 chars 2016-12-26 02:44:06,974 Setting DEBUG logging. 2016-12-26 02:44:06,974 attempt 1/10 2016-12-26 02:44:06,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/447fbe42c556?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-26 02:44:07,298 unpacking tar archive at: mozilla-inbound-447fbe42c556/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:07.482905) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:07.483216) ========= script_repo_revision: 447fbe42c556b91ebd0fe73ee74e699b8fd8f5fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:07.483667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:07.483978) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-26 02:44:07.496003) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-12-26 02:44:07.496303) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:44:07 INFO - MultiFileLogger online at 20161226 02:44:07 in /builds/slave/test 02:44:07 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 02:44:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:44:07 INFO - {'append_to_log': False, 02:44:07 INFO - 'base_work_dir': '/builds/slave/test', 02:44:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:44:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:44:07 INFO - 'branch': 'Mozilla-Inbound', 02:44:07 INFO - 'buildbot_json_path': 'buildprops.json', 02:44:07 INFO - 'config_files': ('talos/linux_config.py',), 02:44:07 INFO - 'default_actions': ('clobber', 02:44:07 INFO - 'read-buildbot-config', 02:44:07 INFO - 'download-and-extract', 02:44:07 INFO - 'populate-webroot', 02:44:07 INFO - 'create-virtualenv', 02:44:07 INFO - 'install', 02:44:07 INFO - 'run-tests'), 02:44:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:44:07 INFO - 'download_minidump_stackwalk': True, 02:44:07 INFO - 'download_symbols': 'ondemand', 02:44:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:44:07 INFO - 'tooltool.py': '/tools/tooltool.py', 02:44:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:44:07 INFO - '/tools/misc-python/virtualenv.py')}, 02:44:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:44:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:44:07 INFO - 'installer_path': 'installer.exe', 02:44:07 INFO - 'log_level': 'info', 02:44:07 INFO - 'log_name': 'talos', 02:44:07 INFO - 'log_to_console': True, 02:44:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:44:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:44:07 INFO - 'opt_config_files': (), 02:44:07 INFO - 'pip_index': False, 02:44:07 INFO - 'sps_profile': False, 02:44:07 INFO - 'sps_profile_interval': 0, 02:44:07 INFO - 'suite': 'dromaeojs-e10s', 02:44:07 INFO - 'system_bits': '32', 02:44:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:44:07 INFO - 'title': 'talos-linux64-ix-037', 02:44:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:44:07 INFO - 'use_talos_json': True, 02:44:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:44:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:44:07 INFO - 'work_dir': 'build'} 02:44:07 INFO - [mozharness: 2016-12-26 10:44:07.858144Z] Running clobber step. 02:44:07 INFO - Running pre-action listener: _resource_record_pre_action 02:44:07 INFO - Running main action method: clobber 02:44:07 INFO - rmtree: /builds/slave/test/build 02:44:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:44:12 INFO - Running post-action listener: _resource_record_post_action 02:44:12 INFO - [mozharness: 2016-12-26 10:44:12.096232Z] Finished clobber step (success) 02:44:12 INFO - [mozharness: 2016-12-26 10:44:12.096402Z] Running read-buildbot-config step. 02:44:12 INFO - Running pre-action listener: _resource_record_pre_action 02:44:12 INFO - Running main action method: read_buildbot_config 02:44:12 INFO - Using buildbot properties: 02:44:12 INFO - { 02:44:12 INFO - "project": "", 02:44:12 INFO - "product": "firefox", 02:44:12 INFO - "script_repo_revision": "production", 02:44:12 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 02:44:12 INFO - "repository": "", 02:44:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 02:44:12 INFO - "buildid": "20161226024328", 02:44:12 INFO - "stage_platform": "linux64-pgo", 02:44:12 INFO - "basedir": "/builds/slave/test", 02:44:12 INFO - "buildnumber": 2358, 02:44:12 INFO - "platform": "ubuntu64_hw", 02:44:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:44:12 INFO - "slavebuilddir": "test", 02:44:12 INFO - "branch": "mozilla-inbound", 02:44:12 INFO - "revision": "447fbe42c556b91ebd0fe73ee74e699b8fd8f5fa", 02:44:12 INFO - "slavename": "talos-linux64-ix-037", 02:44:12 INFO - "builduid": "f403e40d105842f29edd674e5bcd7c6b", 02:44:12 INFO - "repo_path": "integration/mozilla-inbound" 02:44:12 INFO - } 02:44:12 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 02:44:12 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 02:44:12 INFO - Running post-action listener: _resource_record_post_action 02:44:12 INFO - [mozharness: 2016-12-26 10:44:12.100485Z] Finished read-buildbot-config step (success) 02:44:12 INFO - [mozharness: 2016-12-26 10:44:12.100639Z] Running download-and-extract step. 02:44:12 INFO - Running pre-action listener: _resource_record_pre_action 02:44:12 INFO - Running main action method: download_and_extract 02:44:12 INFO - mkdir: /builds/slave/test/build/tests 02:44:12 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')]} 02:44:12 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:44:12 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/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 02:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/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 02:44:12 INFO - Downloaded 1361 bytes. 02:44:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:44:12 INFO - Using the following test package requirements: 02:44:12 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:44:12 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:44:12 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:44:12 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:12 INFO - u'jsshell-linux-x86_64.zip'], 02:44:12 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:44:12 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:44:12 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:44:12 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:44:12 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:44:12 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:44:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:44:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:44:12 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/1482741002/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:44:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:44:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:44:12 INFO - Expected file size: 21829821 02:44:12 INFO - Obtained file size: 21829821 02:44:16 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 02:44:16 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/1482741002/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:44:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:44:16 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:44:16 INFO - Expected file size: 21829821 02:44:16 INFO - Obtained file size: 21829821 02:44:21 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/1482741002/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 02:44:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:44:21 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:44:21 INFO - Expected file size: 14409776 02:44:21 INFO - Obtained file size: 14409776 02:44:21 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')]} 02:44:21 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:44:21 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/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 02:44:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/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 02:44:22 INFO - Downloaded 61378641 bytes. 02:44:22 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:44:22 INFO - mkdir: /builds/slave/test/properties 02:44:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:44:22 INFO - Writing to file /builds/slave/test/properties/build_url 02:44:22 INFO - Contents: 02:44:22 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:44:23 INFO - Running post-action listener: _resource_record_post_action 02:44:23 INFO - Running post-action listener: set_extra_try_arguments 02:44:23 INFO - [mozharness: 2016-12-26 10:44:23.067565Z] Finished download-and-extract step (success) 02:44:23 INFO - [mozharness: 2016-12-26 10:44:23.067801Z] Running populate-webroot step. 02:44:23 INFO - Running pre-action listener: _resource_record_pre_action 02:44:23 INFO - Running main action method: populate_webroot 02:44:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:44:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:44:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:44:23 INFO - '--tppagecycles', 02:44:23 INFO - '7'], 02:44:23 INFO - 'tests': ['tsvgm']}}, 02:44:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:44:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:44:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:44:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:44:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:44:23 INFO - 'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:44:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:44:23 INFO - 'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['damp', 'tps']}, 02:44:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:44:23 INFO - 'tests': ['damp', 'tps']}, 02:44:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['dromaeo_dom']}, 02:44:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:44:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['basic_compositor_video']}, 02:44:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:44:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['a11yr', 02:44:23 INFO - 'ts_paint', 02:44:23 INFO - 'tpaint', 02:44:23 INFO - 'sessionrestore', 02:44:23 INFO - 'sessionrestore_no_auto_restore', 02:44:23 INFO - 'tabpaint']}, 02:44:23 INFO - 'other-e10s': {'tests': ['a11yr', 02:44:23 INFO - 'ts_paint', 02:44:23 INFO - 'tpaint', 02:44:23 INFO - 'sessionrestore', 02:44:23 INFO - 'sessionrestore_no_auto_restore', 02:44:23 INFO - 'tabpaint']}, 02:44:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:44:23 INFO - 'ts_paint', 02:44:23 INFO - 'tpaint', 02:44:23 INFO - 'sessionrestore', 02:44:23 INFO - 'sessionrestore_no_auto_restore', 02:44:23 INFO - 'tabpaint']}, 02:44:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:44:23 INFO - 'ts_paint', 02:44:23 INFO - 'tpaint', 02:44:23 INFO - 'sessionrestore', 02:44:23 INFO - 'sessionrestore_no_auto_restore', 02:44:23 INFO - 'tabpaint']}, 02:44:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['a11yr', 02:44:23 INFO - 'ts_paint', 02:44:23 INFO - 'tpaint', 02:44:23 INFO - 'sessionrestore', 02:44:23 INFO - 'sessionrestore_no_auto_restore', 02:44:23 INFO - 'tabpaint']}, 02:44:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['a11yr', 02:44:23 INFO - 'ts_paint', 02:44:23 INFO - 'tpaint', 02:44:23 INFO - 'sessionrestore', 02:44:23 INFO - 'sessionrestore_no_auto_restore', 02:44:23 INFO - 'tabpaint']}, 02:44:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['tsvgx', 02:44:23 INFO - 'tsvgr_opacity', 02:44:23 INFO - 'tart', 02:44:23 INFO - 'tscrollx', 02:44:23 INFO - 'cart', 02:44:23 INFO - 'tsvg_static']}, 02:44:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:44:23 INFO - 'tsvgr_opacity', 02:44:23 INFO - 'tart', 02:44:23 INFO - 'tscrollx', 02:44:23 INFO - 'cart', 02:44:23 INFO - 'tsvg_static']}, 02:44:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:44:23 INFO - 'talos_options': ['--disable-e10s'], 02:44:23 INFO - 'tests': ['tp5o']}, 02:44:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:44:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:44:23 INFO - 'talos_options': ['--disable-e10s', 02:44:23 INFO - '--xperf_path', 02:44:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:23 INFO - 'tests': ['tp5n']}, 02:44:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:44:23 INFO - 'talos_options': ['--xperf_path', 02:44:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:23 INFO - 'tests': ['tp5n']}}, 02:44:23 INFO - 'talos.zip': {'path': '', 02:44:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:44:23 INFO - Running post-action listener: _resource_record_post_action 02:44:23 INFO - [mozharness: 2016-12-26 10:44:23.089703Z] Finished populate-webroot step (success) 02:44:23 INFO - [mozharness: 2016-12-26 10:44:23.089793Z] Running create-virtualenv step. 02:44:23 INFO - Running pre-action listener: _resource_record_pre_action 02:44:23 INFO - Running main action method: create_virtualenv 02:44:23 INFO - Creating virtualenv /builds/slave/test/build/venv 02:44:23 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 02:44:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:44:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:44:23 INFO - Using real prefix '/usr' 02:44:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:44:23 INFO - Installing distribute.............................................................................................................................................................................................done. 02:44:25 INFO - Installing pip.................done. 02:44:25 INFO - Return code: 0 02:44:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:44:26 INFO - Reading from file tmpfile_stdout 02:44:26 INFO - Output received: 02:44:26 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) 02:44:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:44:26 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')]} 02:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:26 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')]} 02:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:26 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 0xeb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', '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 02:44:26 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 02:44:26 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 02:44:26 INFO - Using env: {'DISPLAY': ':0', 02:44:26 INFO - 'HOME': '/home/cltbld', 02:44:26 INFO - 'LANG': 'en_US.UTF-8', 02:44:26 INFO - 'LANGUAGE': 'en_US:en', 02:44:26 INFO - 'LOGNAME': 'cltbld', 02:44:26 INFO - 'MAIL': '/var/mail/cltbld', 02:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:26 INFO - 'MOZ_NO_REMOTE': '1', 02:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:26 INFO - 'NO_EM_RESTART': '1', 02:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:26 INFO - 'PWD': '/builds/slave/test', 02:44:26 INFO - 'SHELL': '/bin/bash', 02:44:26 INFO - 'SHLVL': '1', 02:44:26 INFO - 'TERM': 'linux', 02:44:26 INFO - 'TMOUT': '86400', 02:44:26 INFO - 'USER': 'cltbld', 02:44:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:26 INFO - '_': '/tools/buildbot/bin/python'} 02:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:26 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 02:44:26 INFO - Cleaning up... 02:44:26 INFO - Return code: 0 02:44:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:44:26 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')]} 02:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:26 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')]} 02:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:26 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 0xeb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', '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 02:44:26 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 02:44:26 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 02:44:26 INFO - Using env: {'DISPLAY': ':0', 02:44:26 INFO - 'HOME': '/home/cltbld', 02:44:26 INFO - 'LANG': 'en_US.UTF-8', 02:44:26 INFO - 'LANGUAGE': 'en_US:en', 02:44:26 INFO - 'LOGNAME': 'cltbld', 02:44:26 INFO - 'MAIL': '/var/mail/cltbld', 02:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:26 INFO - 'MOZ_NO_REMOTE': '1', 02:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:26 INFO - 'NO_EM_RESTART': '1', 02:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:26 INFO - 'PWD': '/builds/slave/test', 02:44:26 INFO - 'SHELL': '/bin/bash', 02:44:26 INFO - 'SHLVL': '1', 02:44:26 INFO - 'TERM': 'linux', 02:44:26 INFO - 'TMOUT': '86400', 02:44:26 INFO - 'USER': 'cltbld', 02:44:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:26 INFO - '_': '/tools/buildbot/bin/python'} 02:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:26 INFO - Downloading/unpacking psutil>=3.1.1 02:44:26 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 02:44:26 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 02:44:26 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 02:44:26 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 02:44:26 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 02:44:26 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 02:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:44:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:28 INFO - Installing collected packages: psutil 02:44:28 INFO - Running setup.py install for psutil 02:44:28 INFO - building 'psutil._psutil_linux' extension 02:44:28 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 02:44:29 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 02:44:29 INFO - building 'psutil._psutil_posix' extension 02:44:29 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 02:44:30 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 02:44:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:30 INFO - Successfully installed psutil 02:44:30 INFO - Cleaning up... 02:44:30 INFO - Return code: 0 02:44:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:44:30 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')]} 02:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:30 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')]} 02:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', '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 02:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:44:30 INFO - Using env: {'DISPLAY': ':0', 02:44:30 INFO - 'HOME': '/home/cltbld', 02:44:30 INFO - 'LANG': 'en_US.UTF-8', 02:44:30 INFO - 'LANGUAGE': 'en_US:en', 02:44:30 INFO - 'LOGNAME': 'cltbld', 02:44:30 INFO - 'MAIL': '/var/mail/cltbld', 02:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:30 INFO - 'MOZ_NO_REMOTE': '1', 02:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:30 INFO - 'NO_EM_RESTART': '1', 02:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:30 INFO - 'PWD': '/builds/slave/test', 02:44:30 INFO - 'SHELL': '/bin/bash', 02:44:30 INFO - 'SHLVL': '1', 02:44:30 INFO - 'TERM': 'linux', 02:44:30 INFO - 'TMOUT': '86400', 02:44:30 INFO - 'USER': 'cltbld', 02:44:30 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:30 INFO - '_': '/tools/buildbot/bin/python'} 02:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:44:30 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 02:44:30 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 02:44:30 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 02:44:30 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 02:44:30 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 02:44:30 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 02:44:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:44:32 INFO - Installing collected packages: mozsystemmonitor 02:44:32 INFO - Running setup.py install for mozsystemmonitor 02:44:32 INFO - Successfully installed mozsystemmonitor 02:44:32 INFO - Cleaning up... 02:44:32 INFO - Return code: 0 02:44:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xeb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', '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 02:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:44:32 INFO - Using env: {'DISPLAY': ':0', 02:44:32 INFO - 'HOME': '/home/cltbld', 02:44:32 INFO - 'LANG': 'en_US.UTF-8', 02:44:32 INFO - 'LANGUAGE': 'en_US:en', 02:44:32 INFO - 'LOGNAME': 'cltbld', 02:44:32 INFO - 'MAIL': '/var/mail/cltbld', 02:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:32 INFO - 'MOZ_NO_REMOTE': '1', 02:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:32 INFO - 'NO_EM_RESTART': '1', 02:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:32 INFO - 'PWD': '/builds/slave/test', 02:44:32 INFO - 'SHELL': '/bin/bash', 02:44:32 INFO - 'SHLVL': '1', 02:44:32 INFO - 'TERM': 'linux', 02:44:32 INFO - 'TMOUT': '86400', 02:44:32 INFO - 'USER': 'cltbld', 02:44:32 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:32 INFO - '_': '/tools/buildbot/bin/python'} 02:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:32 INFO - Downloading/unpacking jsonschema==2.5.1 02:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:44:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:44:34 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 02:44:34 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 02:44:34 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 02:44:34 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 02:44:34 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 02:44:34 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 02:44:35 INFO - Downloading functools32-3.2.3-2.tar.gz 02:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:44:35 INFO - warning: no files found matching '*.txt' 02:44:35 INFO - no previously-included directories found matching 'build' 02:44:35 INFO - no previously-included directories found matching 'dist' 02:44:35 INFO - no previously-included directories found matching '.git*' 02:44:35 INFO - Installing collected packages: jsonschema, functools32 02:44:35 INFO - Running setup.py install for functools32 02:44:35 INFO - warning: no files found matching '*.txt' 02:44:35 INFO - no previously-included directories found matching 'build' 02:44:35 INFO - no previously-included directories found matching 'dist' 02:44:35 INFO - no previously-included directories found matching '.git*' 02:44:35 INFO - Successfully installed jsonschema functools32 02:44:35 INFO - Cleaning up... 02:44:35 INFO - Return code: 0 02:44:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xeb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', '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 02:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:44:35 INFO - Using env: {'DISPLAY': ':0', 02:44:35 INFO - 'HOME': '/home/cltbld', 02:44:35 INFO - 'LANG': 'en_US.UTF-8', 02:44:35 INFO - 'LANGUAGE': 'en_US:en', 02:44:35 INFO - 'LOGNAME': 'cltbld', 02:44:35 INFO - 'MAIL': '/var/mail/cltbld', 02:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:35 INFO - 'MOZ_NO_REMOTE': '1', 02:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:35 INFO - 'NO_EM_RESTART': '1', 02:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:35 INFO - 'PWD': '/builds/slave/test', 02:44:35 INFO - 'SHELL': '/bin/bash', 02:44:35 INFO - 'SHLVL': '1', 02:44:35 INFO - 'TERM': 'linux', 02:44:35 INFO - 'TMOUT': '86400', 02:44:35 INFO - 'USER': 'cltbld', 02:44:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:35 INFO - '_': '/tools/buildbot/bin/python'} 02:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:44:35 INFO - Cleaning up... 02:44:35 INFO - Return code: 0 02:44:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xeb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', '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 02:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:44:35 INFO - Using env: {'DISPLAY': ':0', 02:44:35 INFO - 'HOME': '/home/cltbld', 02:44:35 INFO - 'LANG': 'en_US.UTF-8', 02:44:35 INFO - 'LANGUAGE': 'en_US:en', 02:44:35 INFO - 'LOGNAME': 'cltbld', 02:44:35 INFO - 'MAIL': '/var/mail/cltbld', 02:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:35 INFO - 'MOZ_NO_REMOTE': '1', 02:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:35 INFO - 'NO_EM_RESTART': '1', 02:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:35 INFO - 'PWD': '/builds/slave/test', 02:44:35 INFO - 'SHELL': '/bin/bash', 02:44:35 INFO - 'SHLVL': '1', 02:44:35 INFO - 'TERM': 'linux', 02:44:35 INFO - 'TMOUT': '86400', 02:44:35 INFO - 'USER': 'cltbld', 02:44:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:35 INFO - '_': '/tools/buildbot/bin/python'} 02:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:35 INFO - Downloading/unpacking blobuploader==1.2.4 02:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:44:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:44:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:44:38 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 02:44:38 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 02:44:38 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 02:44:38 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 02:44:38 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 02:44:38 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 02:44:38 INFO - Downloading docopt-0.6.1.tar.gz 02:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:44:38 INFO - Installing collected packages: blobuploader, requests, docopt 02:44:38 INFO - Running setup.py install for blobuploader 02:44:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:44:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:44:38 INFO - Running setup.py install for requests 02:44:39 INFO - Running setup.py install for docopt 02:44:39 INFO - Successfully installed blobuploader requests docopt 02:44:39 INFO - Cleaning up... 02:44:39 INFO - Return code: 0 02:44:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:39 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')]} 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:39 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')]} 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:39 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 0xeb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', '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 02:44:39 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 02:44:39 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 02:44:39 INFO - Using env: {'DISPLAY': ':0', 02:44:39 INFO - 'HOME': '/home/cltbld', 02:44:39 INFO - 'LANG': 'en_US.UTF-8', 02:44:39 INFO - 'LANGUAGE': 'en_US:en', 02:44:39 INFO - 'LOGNAME': 'cltbld', 02:44:39 INFO - 'MAIL': '/var/mail/cltbld', 02:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:39 INFO - 'MOZ_NO_REMOTE': '1', 02:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:39 INFO - 'NO_EM_RESTART': '1', 02:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:39 INFO - 'PWD': '/builds/slave/test', 02:44:39 INFO - 'SHELL': '/bin/bash', 02:44:39 INFO - 'SHLVL': '1', 02:44:39 INFO - 'TERM': 'linux', 02:44:39 INFO - 'TMOUT': '86400', 02:44:39 INFO - 'USER': 'cltbld', 02:44:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:39 INFO - '_': '/tools/buildbot/bin/python'} 02:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:39 INFO - Running setup.py (path:/tmp/pip-3YqLOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:39 INFO - Running setup.py (path:/tmp/pip-_NH3Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:39 INFO - Running setup.py (path:/tmp/pip-yMh7fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:39 INFO - Running setup.py (path:/tmp/pip-ouLdKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:39 INFO - Running setup.py (path:/tmp/pip-BbuSZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:39 INFO - Running setup.py (path:/tmp/pip-B0YV0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:39 INFO - Running setup.py (path:/tmp/pip-1hV6x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:39 INFO - Running setup.py (path:/tmp/pip-FsIP95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:40 INFO - Running setup.py (path:/tmp/pip-jeuEn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:40 INFO - Running setup.py (path:/tmp/pip-ib3Y97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:40 INFO - Running setup.py (path:/tmp/pip-BenUKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:40 INFO - Running setup.py (path:/tmp/pip-ihAvYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:40 INFO - Running setup.py (path:/tmp/pip-Hpim12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:40 INFO - Running setup.py (path:/tmp/pip-tAtwd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:40 INFO - Running setup.py (path:/tmp/pip-LfPOzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:40 INFO - Running setup.py (path:/tmp/pip-rZP04Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:40 INFO - Running setup.py (path:/tmp/pip-AYCdxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:44:40 INFO - Running setup.py install for manifestparser 02:44:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Running setup.py install for mozcrash 02:44:40 INFO - Running setup.py install for mozdebug 02:44:40 INFO - Running setup.py install for mozdevice 02:44:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozfile 02:44:41 INFO - Running setup.py install for mozhttpd 02:44:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozinfo 02:44:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozInstall 02:44:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozleak 02:44:41 INFO - Running setup.py install for mozlog 02:44:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for moznetwork 02:44:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozprocess 02:44:41 INFO - Running setup.py install for mozprofile 02:44:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:44:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:44:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:44:42 INFO - Running setup.py install for mozrunner 02:44:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:44:42 INFO - Running setup.py install for mozscreenshot 02:44:42 INFO - Running setup.py install for moztest 02:44:42 INFO - Running setup.py install for mozversion 02:44:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:44:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:44:42 INFO - Cleaning up... 02:44:42 INFO - Return code: 0 02:44:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:42 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 0xeb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', '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 02:44:42 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 02:44:42 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 02:44:42 INFO - Using env: {'DISPLAY': ':0', 02:44:42 INFO - 'HOME': '/home/cltbld', 02:44:42 INFO - 'LANG': 'en_US.UTF-8', 02:44:42 INFO - 'LANGUAGE': 'en_US:en', 02:44:42 INFO - 'LOGNAME': 'cltbld', 02:44:42 INFO - 'MAIL': '/var/mail/cltbld', 02:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:42 INFO - 'MOZ_NO_REMOTE': '1', 02:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:42 INFO - 'NO_EM_RESTART': '1', 02:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:42 INFO - 'PWD': '/builds/slave/test', 02:44:42 INFO - 'SHELL': '/bin/bash', 02:44:42 INFO - 'SHLVL': '1', 02:44:42 INFO - 'TERM': 'linux', 02:44:42 INFO - 'TMOUT': '86400', 02:44:42 INFO - 'USER': 'cltbld', 02:44:42 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:42 INFO - '_': '/tools/buildbot/bin/python'} 02:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:42 INFO - Running setup.py (path:/tmp/pip-_hG6w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:42 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)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:42 INFO - Running setup.py (path:/tmp/pip-TnzXP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:42 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)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:42 INFO - Running setup.py (path:/tmp/pip-WCVGib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:42 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)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:42 INFO - Running setup.py (path:/tmp/pip-S59_ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:43 INFO - Running setup.py (path:/tmp/pip-oMIHU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:43 INFO - Running setup.py (path:/tmp/pip-dVvlIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:43 INFO - Running setup.py (path:/tmp/pip-VUS3Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:43 INFO - Running setup.py (path:/tmp/pip-hgJmAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:43 INFO - Running setup.py (path:/tmp/pip-GBFYYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:43 INFO - Running setup.py (path:/tmp/pip-oIcG7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:43 INFO - Running setup.py (path:/tmp/pip-PHTnty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:43 INFO - Running setup.py (path:/tmp/pip-fAdmp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:43 INFO - Running setup.py (path:/tmp/pip-ghk1i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:43 INFO - Running setup.py (path:/tmp/pip-EnvCT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:43 INFO - Running setup.py (path:/tmp/pip-Zbbe9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:43 INFO - Running setup.py (path:/tmp/pip-Jf2LxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:43 INFO - Running setup.py (path:/tmp/pip-sYw71H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:43 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)) 02:44:43 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)) 02:44:43 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)) 02:44:43 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)) 02:44:43 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)) 02:44:43 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)) 02:44:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:45 INFO - Downloading blessings-1.6.tar.gz 02:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:44:46 INFO - Installing collected packages: blessings 02:44:46 INFO - Running setup.py install for blessings 02:44:46 INFO - Successfully installed blessings 02:44:46 INFO - Cleaning up... 02:44:46 INFO - Return code: 0 02:44:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:44:46 INFO - Reading from file tmpfile_stdout 02:44:46 INFO - Current package versions: 02:44:46 INFO - argparse == 1.2.1 02:44:46 INFO - blessings == 1.6 02:44:46 INFO - blobuploader == 1.2.4 02:44:46 INFO - docopt == 0.6.1 02:44:46 INFO - functools32 == 3.2.3-2 02:44:46 INFO - jsonschema == 2.5.1 02:44:46 INFO - manifestparser == 1.1 02:44:46 INFO - mozInstall == 1.12 02:44:46 INFO - mozcrash == 1.0 02:44:46 INFO - mozdebug == 0.1 02:44:46 INFO - mozdevice == 0.49 02:44:46 INFO - mozfile == 1.2 02:44:46 INFO - mozhttpd == 0.7 02:44:46 INFO - mozinfo == 0.9 02:44:46 INFO - mozleak == 0.1 02:44:46 INFO - mozlog == 3.4 02:44:46 INFO - moznetwork == 0.27 02:44:46 INFO - mozprocess == 0.23 02:44:46 INFO - mozprofile == 0.28 02:44:46 INFO - mozrunner == 6.13 02:44:46 INFO - mozscreenshot == 0.1 02:44:46 INFO - mozsystemmonitor == 0.3 02:44:46 INFO - moztest == 0.7 02:44:46 INFO - mozversion == 1.4 02:44:46 INFO - psutil == 3.1.1 02:44:46 INFO - requests == 1.2.3 02:44:46 INFO - wsgiref == 0.1.2 02:44:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:46 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')]} 02:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:46 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')]} 02:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:46 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 0xeb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', '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 02:44:46 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 02:44:46 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 02:44:46 INFO - Using env: {'DISPLAY': ':0', 02:44:46 INFO - 'HOME': '/home/cltbld', 02:44:46 INFO - 'LANG': 'en_US.UTF-8', 02:44:46 INFO - 'LANGUAGE': 'en_US:en', 02:44:46 INFO - 'LOGNAME': 'cltbld', 02:44:46 INFO - 'MAIL': '/var/mail/cltbld', 02:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:46 INFO - 'MOZ_NO_REMOTE': '1', 02:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:46 INFO - 'NO_EM_RESTART': '1', 02:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:46 INFO - 'PWD': '/builds/slave/test', 02:44:46 INFO - 'SHELL': '/bin/bash', 02:44:46 INFO - 'SHLVL': '1', 02:44:46 INFO - 'TERM': 'linux', 02:44:46 INFO - 'TMOUT': '86400', 02:44:46 INFO - 'USER': 'cltbld', 02:44:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:46 INFO - '_': '/tools/buildbot/bin/python'} 02:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:46 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)) 02:44:46 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)) 02:44:46 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)) 02:44:46 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)) 02:44:46 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)) 02:44:46 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)) 02:44:46 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)) 02:44:46 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)) 02:44:46 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)) 02:44:46 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)) 02:44:46 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)) 02:44:46 INFO - Cleaning up... 02:44:46 INFO - Return code: 0 02:44:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:44:46 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')]} 02:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:46 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')]} 02:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:46 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 0xeb81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', '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 02:44:46 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 02:44:46 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 02:44:46 INFO - Using env: {'DISPLAY': ':0', 02:44:46 INFO - 'HOME': '/home/cltbld', 02:44:46 INFO - 'LANG': 'en_US.UTF-8', 02:44:46 INFO - 'LANGUAGE': 'en_US:en', 02:44:46 INFO - 'LOGNAME': 'cltbld', 02:44:46 INFO - 'MAIL': '/var/mail/cltbld', 02:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:46 INFO - 'MOZ_NO_REMOTE': '1', 02:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:46 INFO - 'NO_EM_RESTART': '1', 02:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:46 INFO - 'PWD': '/builds/slave/test', 02:44:46 INFO - 'SHELL': '/bin/bash', 02:44:46 INFO - 'SHLVL': '1', 02:44:46 INFO - 'TERM': 'linux', 02:44:46 INFO - 'TMOUT': '86400', 02:44:46 INFO - 'USER': 'cltbld', 02:44:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:46 INFO - '_': '/tools/buildbot/bin/python'} 02:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:44:46 INFO - Cleaning up... 02:44:46 INFO - Return code: 0 02:44:46 INFO - Running post-action listener: _resource_record_post_action 02:44:46 INFO - Running post-action listener: _start_resource_monitoring 02:44:46 INFO - Starting resource monitoring. 02:44:46 INFO - [mozharness: 2016-12-26 10:44:46.973592Z] Finished create-virtualenv step (success) 02:44:46 INFO - [mozharness: 2016-12-26 10:44:46.974049Z] Running install step. 02:44:46 INFO - Running pre-action listener: _resource_record_pre_action 02:44:46 INFO - Running main action method: install 02:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:44:47 INFO - Reading from file tmpfile_stdout 02:44:47 INFO - Detecting whether we're running mozinstall >=1.0... 02:44:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:44:47 INFO - Reading from file tmpfile_stdout 02:44:47 INFO - Output received: 02:44:47 INFO - Usage: mozinstall [options] installer 02:44:47 INFO - Options: 02:44:47 INFO - -h, --help show this help message and exit 02:44:47 INFO - -d DEST, --destination=DEST 02:44:47 INFO - Directory to install application into. [default: 02:44:47 INFO - "/builds/slave/test"] 02:44:47 INFO - --app=APP Application being installed. [default: firefox] 02:44:47 INFO - mkdir: /builds/slave/test/build/application 02:44:47 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'] 02:44:47 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 02:45:04 INFO - Reading from file tmpfile_stdout 02:45:04 INFO - Output received: 02:45:04 INFO - /builds/slave/test/build/application/firefox/firefox 02:45:04 INFO - Running post-action listener: _resource_record_post_action 02:45:04 INFO - [mozharness: 2016-12-26 10:45:04.598399Z] Finished install step (success) 02:45:04 INFO - [mozharness: 2016-12-26 10:45:04.598675Z] Running run-tests step. 02:45:04 INFO - Running pre-action listener: _resource_record_pre_action 02:45:04 INFO - Running main action method: run_tests 02:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:45:04 INFO - Python 2.7.3 02:45:04 INFO - Return code: 0 02:45:04 INFO - grabbing minidump binary from tooltool 02:45: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')]} 02:45:04 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 0x1227820>, '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 0x1228520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12289b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:45:04 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 02:45:04 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 02:45:04 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 02:45:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:45:04 INFO - Return code: 0 02:45:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:45:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:45:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:45:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:45:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:45:04 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/1482741002/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 02:45:04 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/1482741002/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 02:45:04 INFO - Using env: {'DISPLAY': ':0', 02:45:04 INFO - 'HOME': '/home/cltbld', 02:45:04 INFO - 'LANG': 'en_US.UTF-8', 02:45:04 INFO - 'LANGUAGE': 'en_US:en', 02:45:04 INFO - 'LOGNAME': 'cltbld', 02:45:04 INFO - 'MAIL': '/var/mail/cltbld', 02:45:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:45:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:04 INFO - 'MOZ_NO_REMOTE': '1', 02:45:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:04 INFO - 'NO_EM_RESTART': '1', 02:45:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:04 INFO - 'PWD': '/builds/slave/test', 02:45:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:45:04 INFO - 'SHELL': '/bin/bash', 02:45:04 INFO - 'SHLVL': '1', 02:45:04 INFO - 'TERM': 'linux', 02:45:04 INFO - 'TMOUT': '86400', 02:45:04 INFO - 'USER': 'cltbld', 02:45:04 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105', 02:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:04 INFO - '_': '/tools/buildbot/bin/python'} 02:45:04 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/1482741002/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 02:45:04 INFO - mozversion application_buildid: 20161226003002 02:45:04 INFO - mozversion application_changeset: 447fbe42c556b91ebd0fe73ee74e699b8fd8f5fa 02:45:04 INFO - mozversion application_display_name: Nightly 02:45:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:45:04 INFO - mozversion application_name: Firefox 02:45:04 INFO - mozversion application_remotingname: firefox 02:45:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:45:04 INFO - mozversion application_vendor: Mozilla 02:45:04 INFO - mozversion application_version: 53.0a1 02:45:04 INFO - mozversion platform_buildid: 20161226003002 02:45:04 INFO - mozversion platform_changeset: 447fbe42c556b91ebd0fe73ee74e699b8fd8f5fa 02:45:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:45:04 INFO - mozversion platform_version: 53.0a1 02:45:04 INFO - using testdate: 1482749104 02:45:04 INFO - actual date: 1482749104 02:45:04 INFO - starting webserver on 'localhost:42003' 02:45:04 INFO - SUITE-START | Running 2 tests 02:45:04 INFO - TEST-START | dromaeo_css 02:45:04 INFO - operating with platform_type : linux_ 02:45:04 INFO - Initialising browser for dromaeo_css test... 02:45:05 INFO - TEST-INFO | started process 3332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ByNXP/profile http://localhost:42003/getInfo.html) 02:45:05 INFO - PROCESS | 3332 | 1482749105909 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:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 02:45:10 INFO - PROCESS | 3332 | __metrics Screen width/height:1600/1200 02:45:10 INFO - PROCESS | 3332 | colorDepth:24 02:45:10 INFO - PROCESS | 3332 | Browser inner width/height: 1024/697 02:45:10 INFO - PROCESS | 3332 | __metrics 02:45:10 ERROR - PROCESS | 3332 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 02:45:11 INFO - TEST-INFO | 3332: exit 0 02:45:11 INFO - Browser initialized. 02:45:11 INFO - Running cycle 1/1 for dromaeo_css test... 02:45:11 INFO - TEST-INFO | started process 3453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ByNXP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:23 INFO - PROCESS | 3453 | RSS: Main: 154451968 02:45:23 INFO - PROCESS | 3453 | 02:48:23 INFO - PROCESS | 3453 | Cycle 1(1): loaded http://localhost:42003/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42003/tests/dromaeo/cssquery-ext.html) 02:48:24 INFO - PROCESS | 3453 | RSS: Main: 164671488 02:48:24 INFO - PROCESS | 3453 | 02:50:12 INFO - PROCESS | 3453 | ************************* 02:50:12 INFO - PROCESS | 3453 | A coding exception was thrown and uncaught in a Task. 02:50:12 INFO - PROCESS | 3453 | 02:50:12 INFO - PROCESS | 3453 | Full message: ReferenceError: fetch is not defined 02:50:12 INFO - PROCESS | 3453 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 02:50:12 INFO - PROCESS | 3453 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 02:50:12 INFO - PROCESS | 3453 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 02:50:12 INFO - PROCESS | 3453 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:50:12 INFO - PROCESS | 3453 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:50:12 INFO - PROCESS | 3453 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:50:12 INFO - PROCESS | 3453 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 02:50:12 INFO - PROCESS | 3453 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:50:12 INFO - PROCESS | 3453 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:50:12 INFO - PROCESS | 3453 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:50:12 INFO - PROCESS | 3453 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 02:50:12 INFO - PROCESS | 3453 | 02:50:12 INFO - PROCESS | 3453 | ************************* 02:51:26 INFO - PROCESS | 3453 | Cycle 1(1): loaded http://localhost:42003/tests/dromaeo/cssquery-ext.html (next: http://localhost:42003/tests/dromaeo/cssquery-jquery.html) 02:51:27 INFO - PROCESS | 3453 | RSS: Main: 159694848 02:51:27 INFO - PROCESS | 3453 | 02:54:29 INFO - PROCESS | 3453 | Cycle 1(1): loaded http://localhost:42003/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42003/tests/dromaeo/cssquery-mootools.html) 02:54:30 INFO - PROCESS | 3453 | RSS: Main: 167485440 02:54:30 INFO - PROCESS | 3453 | 02:57:31 INFO - PROCESS | 3453 | Cycle 1(1): loaded http://localhost:42003/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42003/tests/dromaeo/cssquery-prototype.html) 02:57:32 INFO - PROCESS | 3453 | RSS: Main: 160440320 02:57:32 INFO - PROCESS | 3453 | 03:00:35 INFO - PROCESS | 3453 | Cycle 1(1): loaded http://localhost:42003/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42003/tests/dromaeo/cssquery-yui.html) 03:00:35 INFO - PROCESS | 3453 | RSS: Main: 164413440 03:00:35 INFO - PROCESS | 3453 | 03:03:38 INFO - PROCESS | 3453 | Cycle 1(1): loaded http://localhost:42003/tests/dromaeo/cssquery-yui.html (next: http://localhost:42003/tests/dromaeo/cssquery-dojo.html) 03:03:38 INFO - PROCESS | 3453 | RSS: Main: 164306944 03:03:38 INFO - PROCESS | 3453 | 03:03:38 INFO - PROCESS | 3453 | __start_tp_report 03:03:38 INFO - PROCESS | 3453 | _x_x_mozilla_page_load 03:03:38 INFO - PROCESS | 3453 | _x_x_mozilla_page_load_details 03:03:38 INFO - PROCESS | 3453 | |i|pagename|runs| 03:03:38 INFO - PROCESS | 3453 | |0;dojo.html;3103.5344698295253;3146.6224053113615;3156.210947263184;3200.951985720214;3202.50361194015;5209;5363.544098751606;5393;5402.135658294674;5419.918701219485;5271.841844744664;5356.839294821161;5520.06158952978;5524.309461317335;5541.362743284523;4804.83183088592;4843.878903027417;4846.466888642264;4953.1332016896895;4960.627952903546;4767.284907263904;4927.728974906378;4930.260460930853;4949.529794669518;4950.925736113961;4774.355462012619;4813.350197723297;4937.2840938063955;4955.479674634147;4970.13022721026;4795.352627395292;4805.255185446262;4825.20384136617;4891.8777030574165;4936.8765780855765;4839.128956787777;4846.927296090562;4853.781579828917;4870.756462176877;4887.951120488785;5268.683878967274;5321.840344789663;5331.866703332447;5369.5972802040005;5404.243405923174;5615.185798059259;5665.12190610456;5666.744996475128;5690.9146362804595;5779.739911703941;5731.799387021476;5738.081906894877;5739.62692424991;5743.253377060955;5747.339056008529;5344.385395679507;5349.786008559653;5353.812616558402;5357.089294819929;5390.676559406448;5723.971380143073;5780.150351887356;5785.595008349375;5799.623024503394;5805.303363596311;5606.635568688103;5621.775128994795;5644.97177514118;5647.802326918621;5676.4323567642905;5654.547636189095;5684.914726279109;5739.081746920473;5744.540436765049;5753.741081651336;5581.6930068845795;5615.438456154434;5699.401562835926;5738.512226460714;5776.133579963039;5809.593328466966;5810.593258471867;5820.417958204146;5822.155787410887;5863.179154918314;4352.2818734909015;4362.411074504901;4394.472663280363;4407.933880991788;4455.376247325377;3835.194609132058;3853.344931361675;3878.8836334909997;3897.590752970954;3966.8809935701975;5569.275994120739;5569.526590239875;5604.544387212176;5615.101583746581;5626.803061892814;5796;5848.590598658138;5852.297724273029;5863.941360586425;5866.266716660418;5283.339582552181;5396;5564.749586268627;5582.358028826656;5586.636868603528;4798.47216806151;4851.951480485221;4855.8057677693205;4872.366592342973;4906.460289368167;6031.09533569968;6039.094135879565;6041.8489537761025;6065.939340606537;6081.726322315506;5611.971940140274;5885.94114058871;5886.352501224947;5896.115582662464;5902.203202567598;5847.707614619167;5854.414558544111;5884.58807883444;5888.528917686661;5969.850753731192;5624.268845050117;5663.093904975184;5674.829755107354;5675.375708672125;5677.687727175045;5711.971440142773;5728.627639203439;5740.339860916049;5759.8560035999435;5765.106408506688;5459.617826752089;5511.641743286834;5532.087205611029;5571.637843540157;5602.831915042555;5646.265985421869;5650.152477128464;5652.293463317085;5664.5751568631695;5712.571557133315;5469;5617.32592088952;5627.943720562742;5663.3770285267765;5663.66018038919;5561.332640083216;5655.321361436654;5686.402927692533;5690.658560486218;5769.249997500298;5524.33707955048;5569.582281328835;5574.665520068809;5578.051731205624;5590.161475778666 03:03:38 INFO - PROCESS | 3453 | |1;ext.html;545.5690004896132;558.3439458636104;568.3747877334935;587.8589138606735;601.1403692719413;40864.38703419447;43107.78446107769;43238.78380608092;46560.76719616397;46594.3119385301;44143.55856441434;44350.55649443505;44486.555134448645;44818.77590612043;44918;8856.291496680251;9035.954820225923;9046.416877046491;9056.954715226415;10101.242406819481;10158.238132140119;10228.846567301496;10250.846237306447;10259.948700256487;10267.281290309682;10224.74438139045;10258.846117308247;10314.226433017517;10335.896641033607;10355.844662330072;10269.948650256776;10275.794484110313;10305.12406445453;10325.173986081096;10334.534945927413;10211.591536338612;10223.693289201336;10310.896891031069;10326.432046237529;10351.430671313075;37792.43311350332;38167;38356.424653630216;38396.616033839586;38555.42166867499;3991.860284890044;4009.848051528183;4048.959510404917;4112.321466957948;4122.587741225883;29251.707482925325;29393.853030734925;29643.55534666982;29869.70130298691;29964.70035299641;3791.298609757204;3809.3333666608232;3818.909762858024;3840.116773142165;3844.9807750961345;338827;338923;340359;340988;342359;51762.741186293824;51848;51931;52033.479665203624;52085.47914520882;53735.73132134314;53971;54041.45958540443;54160.18759718607;54244.18633720497;15035.248237588077;15527.146006969499;15541.922290388702;15559.533214003599;15624.375024998873;11718.765624687458;11993.820092698617;12010.63968080959;12290.787658221427;12399.504019839105;16496;16637.833621663627;16699.165041747863;16729.403178316476;16732.498025059267;6600.141981542369;6670.132882725215;6787.219469760942;6961.93038069623;7059.89410158848;895.1138373010673;911.252772726358;911.4713466189594;913.7487191022522;919.8114386550741;26853.328666783094;28774.856125719238;29273.414531709674;30085.849570752005;30232.84883575568;1047.4657924458581;1050.8844027157006;1060.8726952765717;1064.6752740414247;1065.7602039541196;14028.368723407471;14191.422427524747;14349.426022959173;14375.209363484899;14627.707445851023;523791;530604;530831;531484;532922;47946;48425.5157448421;48545.27182092201;48550;48568.27147592789;1377.7864431013008;1378;1392.4012674549838;1393.0248825821966;1405.3956798576505;26420.603690945034;27200.863995679894;27223;27309.117276040695;28160.577591336558;43356;44094;44114.33828492511;44201.11597768091;44238.778806105765;470319;473668;476005;477196;478342;24394.75605243925;25312.114076007252;25599;25624.359391015372;27108.45783084288;38821.61178388293;38893.41659875161;39309.21381572296;39763.40354894737;39969.80015100022;32695;35496.645033549335;35529.289414212086;35580.28839423249;35640;34947.47578786269;35160.82419587886;35475.46786798148;35546.644533555365;35685.46471802873;35140;35444.29111417705;35997;36201.818990904874;36827.63172368242;30453.54319685162;32710.672893271716;32855.67144328526;32929.835350823094;33086.83456582702;25730.614040789776;25804.741952580986;26110.216693499224;26150.73849261483;26214.73785262123 03:03:38 INFO - PROCESS | 3453 | |2;jquery.html;400.5553835242882;406.72952486596415;413.4583695359079;414.95435502094773;428.6677824685868;17434.73847892281;18881.24475021001;18954.431367058995;18965;19074.523136921584;18337.449876503728;18734.625307493843;18875.716864247046;18912.43262702121;18913.7162942556;5200.297959775438;5268.473152684739;5368.70472124033;5379.466851947196;5422.864428389283;5312.973435132838;5368.758405871745;5393.622446428732;5401.189821526783;5403.621746477748;5318;5360.517553420192;5753.223314852504;5785.190073389729;5795.130730390433;5723.112917497794;5733.770649174028;5767.307923049261;5770.826875193751;5794.855128621797;5021.598272138257;5182.352205974254;5234.0840352938085;5238.842834714965;5241.895162096775;13958.790618140736;13966.790498142536;14003.089799163023;14096.577102686935;14107.647308817363;2693.7844972402163;2787.9442411151867;2795.35706787438;2798.860056997142;2967.896123635662;10181.08370246674;10280.434576098312;10395.740106497322;10840.186985976005;10888.891111088946;1946.766388033445;2006.8795872247713;2017.3947815655392;2024.1498570600384;2025.939221823333;54376.912461750544;81448;81785.59107204426;81968.59015704943;83140.16859831384;10364.378137311785;10637.9468102659;11027.456156138147;11087.390193539271;11124.165687573464;12281.93859030699;12895.613131606067;15555.911086224081;15636.530904072668;15647;7857.2928436441;7889.3294070004695;7902.209779022167;7949.682012719542;8050.355971522265;7869.606519673994;7872.567008814455;8000.8799868002025;8045.275925166763;8195.631196596167;4111.527174374925;4178.331466965271;4182.519010313853;4197.307444271661;4293.720908141024;1999.2502811445709;2024.8154829424952;2041.5712700333097;2054.4247610669036;2079.08520251089;464.3893280336347;464.4797826434415;879.4371602174614;906.7914379692708;924.6347692661361;11335.206535542598;11631.59289424866;11879.762404751857;11983.64049078529;12229.93885030569;493.86418734848206;495.2299174783175;496.1738705056041;498.7058582977169;498.88026873550086;6413.647249401234;6433.967830160913;6466.1270728452;6606;6616.636085015371;477005;477969;478981;503243;516005;86994.56502717445;89465.55267223752;91122.54438727896;91319.54340228256;92588.53705731429;1055.678018204455;1094.7099018759875;1105.723569107723;1110.4281295133012;1110.6834552152598;16721.66556668884;16882.409115680894;16951.237194326037;16970.151492425084;17133.74299385535;39396.01509962274;39870.60129398785;40092;40104;41132.177356452106;54362.18456723073;55660;55824.16263755965;56739;57593.13610295765;7640.885386719315;7986.720464783704;8464.349451857075;8496.362772791941;8756.562171891508;12961.09272350964;13438.328083595976;13459.79810302866;13536.864631353954;13630.659233519242;11401.833651606168;11645.59240426581;12068.33624150645;12125.878741212828;12219.633410997329;11174.608888688857;11518.82721759191;11588.88411115878;11666.625015619144;12035.879641203475;11668.416579171177;11726.589569365373;11974.58088966882;12045.578404755792;12107.394630268627;8213.79465513367;8513.19124683154;8664.263537599374;8778.473291602524;8808.119188081397;9948.502574871372;11818.468168932246;11857.16999810005;11974.401279936143;12102 03:03:38 INFO - PROCESS | 3453 | |3;mootools.html;1372.6499742565645;1376.9311534423277;1382.3710211853609;1396.9371378287976;1406.8311802583692;7775.805604859881;7958.522488650685;8231.958840205798;8566.999999999993;8597.613107410167;8194.631241594128;8425.07324194338;8425.36809739269;8631.136886311366;8665.653373865054;2343.7304709958403;2363.846349987254;2364.574376612209;2383.344580240439;2383.559041577305;2297.161536039342;2317.9768202318014;2349.89425475854;2358.6344116661944;2377.1561095811;2323.477217626029;2336.6845475860796;2342.531493701258;2342.6954495915506;2343.2852979841227;2259.435141214696;2298.333483289844;2304.5275718477674;2313.90744370225;2316.143027079974;2324.151684635096;2326.8371214015024;2339.836211465198;2346.2609278077352;2348.2250857217077;8602.09677983809;8688.131186881325;8768.780780480476;8773.429727067783;8780.604872780741;5209.426963034063;5318.175682769177;5329.280547126127;5345.278387417688;5348.465153484659;3182.793118447317;3316.6849149330774;3392.1858753899132;3413.5903691556923;3418.8290585470877;1391.7286129204808;1396.9092009019382;1423.5800438870558;1465.9486917957927;1490.4932323010228;11814.527418903233;11902.047836173086;11906.28562286257;11969.102317326235;12000.759984800256;4258.510271318838;4541.227991241497;4542.613877820356;4626.791794369262;4628.467726211461;9613.855792163124;9632.807343853225;9635.855462168072;9642.469664168539;9646.469444180497;5036.546710795973;5157.535821775983;5271.3674359076385;5292.2326262691695;5306.257124002643;4592.724436533818;4607.838725644587;4639.652026098056;4648.814047438064;4708.764561771966;3622.836972336251;3646.1431563582537;3741.9625803741615;3761.5110035695184;3779.9433008504893;1139.652406016173;1156.7686462707493;1171.344047333496;1176.952921883115;1176.988230117705;804.8229389534293;827.2637352756052;828.5774255129807;830.1781236575747;831.8086840026707;5578.497935185772;5602.467765562265;5627.437256274422;5784.132380143013;5998.700064996733;945.8864936207561;964.2816102004052;976.4336684722844;985.1822986920981;989.1048601016092;3582.570091588974;3787.5454945406727;3802.296575133609;3906.687465002793;4025;10220.386776793268;10431.16550675944;10444;10497.895021049844;10527.736806579896;9592.856107158399;10084.848727269096;10375.27373083892;10397.896021039844;10457.633982810565;7992.3606111510935;8144.959275203586;8168.509889406655;8184.304334131546;8188.713395031145;5916.437938395846;5963.254593175853;6079.240094988127;6118.510519158545;6280.842978925563;8906.688265910661;9501.952490237505;9524.238060955246;9530.1899338557;9608.567614457506;9313.906860931304;9524.333296669167;9534.332596718163;9602.66390676323;9635.614575416905;6841.692123854339;7487.138979017483;7707.499012564165;7708.576028318272;7731.188225236494;7746.922530774846;7964.960175199087;8087.757367278991;8091.474054186459;8108.189181081844;7026.929730702627;7121.679524421517;7177.851543752974;7233.0597022386755;7312.049433573814;6858.279880612663;7111.466640002124;7211.098612673416;7222.494425390172;7280.453965952469;5972.671503067199;6011;6054.576179667381;6102.115193296859;6125.173101631222;4781.211100168433;4806;4836.46798852133;4872.074305881871;4930.852074437773;4562.406887104655;4614.423197100363;4655.906881862412;4763.261694437368;4865.1242776300605 03:03:38 INFO - PROCESS | 3453 | |4;prototype.html;389.2934324201574;401.86135783154805;405.2138850629778;406.6726285340302;414.3163779763392;5258.316418865542;5332.840014799563;5487.670739755617;5514.36584792749;5519.11694128939;5304.2043693446;5362.115250983593;5381.865453363668;5387.171734839211;5435.374931882835;4287.82848686053;4300.290452075419;4301;4307.396964424983;4360.760158191299;4002.2195671844;4165.875023749277;4322.487129504664;4338.783060846961;4360.389545463638;4152.68854835887;4154.273002224613;4159.525082575862;4159.604837540444;4173.102782901676;4170.666346692257;4180.745776267138;4189.916201675965;4196.601322874322;4231.746095234295;3726.142987112979;3748.4189950557707;3752.605976372469;3754.4743735877;3755.267722794056;5163.3545806774155;5217.739113044333;5250.291210686547;5254.4220135785035;5293.417724050351;4817.710937343771;4850.660453768238;4856;4863.294822250789;4864.878378040542;5511.53151982082;5630.408807075239;5676.801311954062;5690.459406356389;5698.629589076697;4051.97974010131;4082.0201253085415;4083.203775263825;4099.3031184698675;4104.8152833122585;5915.1551491530845;5922.466977972003;5929.881402371929;5961.52307815378;5963.4334738199805;4133.42132101506;4211.936820947688;4224.408582798411;4228.76741779199;4241.367073676657;4205.306124489425;4220.6412454941055;4245.596668316567;4247.320428731388;4247.3628955656895;4812.927806082912;4815.807367705253;4827.662063655581;4832.130216561053;4846.29728689338;5608.411116832755;5697.686627235459;5705.828825135252;5733.512651424676;5763.7982670606325;1433.6630891740433;1434.2756907761514;1436.7988481612583;1436.920969346696;1441.322578388177;938.9765255868658;975.8438649816137;979.128575567731;995.915347195482;998.1914649134225;5211.348581427322;5238.061917090701;5267.762950667229;5269.762860671279;5272.657277276965;5507.201455788968;5541.390447050821;5556.388797232301;5572.024895643246;5656.642405822655;5128.6151140248;5273.604479664041;5318.282031925718;5347;5348.839534813962;2987.1038688393396;2989.7309242168308;3002.5045867431627;3012.834294113845;3023.561583570414;5662.8301150965535;5825.611499285357;5850.385709500526;5857.882842343214;5909.734061967221;5628.324601047901;5680.801171958961;5685.232493613392;5701.4013528579735;5727.427257274323;5833.970830145907;5854.443827836349;5869.530437564985;5883.323417807007;5891.558133139946;5485.6434331768305;5587.636803607753;5618.719064046863;5646.209530665628;5668.234788303526;5515.255440515479;5530.364008138955;5531.197976293334;5538.529225015757;5626.38109807929;5890.611494436672;5892.204552385373;5901.7639294427745;5903.284489135046;5919.852003699942;3876.96123038766;4007.499062617173;4063.756174629532;4202.411662367333;4212.578742125763;5850.795222167204;5856;5870.706464676664;5876.41235876409;5896.557758168069;5625.493705566519;5701.831124619526;5710.857228569319;5718.742656580381;5755.424457554211;5545.195946587642;5699.572532060195;5704.629199102045;5729.312482502127;5734.34055083654;5622.578306626938;5665.603407761582;5675.666218438746;5690.430956904276;5699.544036477155;5514.648911016827;5647.5481961442165;5687.516561092188;5708.514776244066;5745.3105627324985;5509.173623956439;5593.244911936837;5598.384177740527;5605.075162598126;5615.382307946041 03:03:38 INFO - PROCESS | 3453 | |5;yui.html;705.7212401101568;757.303280981497;764.6826566974704;766.7623036858571;787.4055088408251;16221.91889040556;17279.913600432013;17330.826691733095;17343.913280433597;17366.56583585408;15753.212339383042;15901.363945442168;15914.363425462967;15942.123183224947;15960.521184364488;693.7571849852561;715.3454589051038;784.5763287824568;799.0810567846964;812.8658771302743;826.4380221449412;832.3008672714918;832.4838600067936;832.8667413213886;833.1918039501704;874.8381549413347;878.3368556739653;879.1296616349831;879.3229213505597;880.4365206267994;859.2138193552892;861.0829466618063;869.7695110795676;869.8390797702414;870.9259712924409;635.0854769132435;636.522608043967;640.3308542573022;641.2497378067673;642.0465608571268;15778.526644200692;16164.515064547964;16166.515004549765;16555.91722041394;16717.164141792862;14524.56426307202;14721.190334531597;14847.331870065873;15140;15218.695626087527;11441.885581144164;11699.473523691455;11873.16887817853;11942.880571194351;12194.451249693786;4391.099824535962;4392.846250381222;4416.2713152329825;4491.101779644052;4529.116822219668;79545;81581.59209203917;82618.58690706508;83094.58452707698;83258.58370708168;11313.151513636345;11406.771864562663;11431.314121152758;11473.942630286796;11499.770004600028;22166.556668866855;22483;22643.320700378685;22704.205352812573;22913.541729165325;8264.586770661443;8300.750977470685;8335.708250211213;8573.871391929126;8700;4538.636909047268;4648.907021859543;4692.53074692528;4729.43246810385;4803.423589169252;3714.68425183857;3752.3058234226755;3768.378217594121;3796.7911764853197;3802.6957843372466;650.6551527690332;656.0487293424553;662.5991275278484;666.7632990288474;674.922383925845;726.1866709285529;736.2674139231499;745.2100773180446;758.1470845299039;782.307657722908;9198.724038278862;9248;9713.61145554184;9868.111869931741;10081.042300981542;735.9411247100326;739.7004213293625;753.2467532467532;762.7254188492138;767.0795045944889;4221.387898754663;4408.4930233023615;4509.7970591323465;4544.0457503924545;4569.2689169732685;77361;80756.19243807605;82215.588922055;83414;86869.56565217134;72596.27403725895;72632.63683681653;74384;76071;76160.9999999989;64402.677986609764;65261.67369163124;66718.66640666862;67757.6612116946;69208.65395672989;8594.613242404232;8689.17452841979;8876.778080548038;9019.729408117766;9033.638654453749;44457.33314000228;45535.31697024614;45780;46082.76958615185;46324.7683761579;55613.443865560825;57110.428895712175;57520.71239643775;57610.423895760505;59239.40760592339;12224.266544007389;12319.384030798603;12618.053645976404;12867.935660322013;13125.803112953123;15436.614084647974;15552.37790488413;15650.530484085495;15864.841351586336;16684.49946501607;12393.194442361219;13272.80090798658;15293.158876261912;15295;15305.770413443584;12459.688507787378;14017.929910350384;14409.207493587954;14707.338169782171;14733.55799326022;14070.507532236323;14199.503017394341;14750.926245369134;14763.704725905636;15099.698006040038;11764.294142351486;11868.703282418008;12374.319412432402;12679.049071319872;12769.87230127724;11577.421128943688;11580.42097895085;11641;11675.677818690032;11905.583304584645 03:03:38 INFO - PROCESS | 3453 | __end_tp_report 03:03:38 INFO - PROCESS | 3453 | __start_cc_report 03:03:38 INFO - PROCESS | 3453 | _x_x_mozilla_cycle_collect,295 03:03:38 INFO - PROCESS | 3453 | __end_cc_report 03:03:38 INFO - PROCESS | 3453 | __startTimestamp1482750218947__endTimestamp 03:03:38 INFO - PROCESS | 3453 | 03:03:38 INFO - PROCESS | 3453 | ------- Summary: start ------- 03:03:38 INFO - PROCESS | 3453 | Number of tests: 6 03:03:38 INFO - PROCESS | 3453 | 03:03:38 INFO - PROCESS | 3453 | [#0] dojo.html Cycles:165 Average:5345.66 Median:5586.64 stddev:611.40 (10.9%) stddev-sans-first:587.43 03:03:38 INFO - PROCESS | 3453 | Values: 3103.5 3146.6 3156.2 3201.0 3202.5 5209.0 5363.5 5393.0 5402.1 5419.9 5271.8 5356.8 5520.1 5524.3 5541.4 4804.8 4843.9 4846.5 4953.1 4960.6 4767.3 4927.7 4930.3 4949.5 4950.9 4774.4 4813.4 4937.3 4955.5 4970.1 4795.4 4805.3 4825.2 4891.9 4936.9 4839.1 4846.9 4853.8 4870.8 4888.0 5268.7 5321.8 5331.9 5369.6 5404.2 5615.2 5665.1 5666.7 5690.9 5779.7 5731.8 5738.1 5739.6 5743.3 5747.3 5344.4 5349.8 5353.8 5357.1 5390.7 5724.0 5780.2 5785.6 5799.6 5805.3 5606.6 5621.8 5645.0 5647.8 5676.4 5654.5 5684.9 5739.1 5744.5 5753.7 5581.7 5615.4 5699.4 5738.5 5776.1 5809.6 5810.6 5820.4 5822.2 5863.2 4352.3 4362.4 4394.5 4407.9 4455.4 3835.2 3853.3 3878.9 3897.6 3966.9 5569.3 5569.5 5604.5 5615.1 5626.8 5796.0 5848.6 5852.3 5863.9 5866.3 5283.3 5396.0 5564.7 5582.4 5586.6 4798.5 4852.0 4855.8 4872.4 4906.5 6031.1 6039.1 6041.8 6065.9 6081.7 5612.0 5885.9 5886.4 5896.1 5902.2 5847.7 5854.4 5884.6 5888.5 5969.9 5624.3 5663.1 5674.8 5675.4 5677.7 5712.0 5728.6 5740.3 5759.9 5765.1 5459.6 5511.6 5532.1 5571.6 5602.8 5646.3 5650.2 5652.3 5664.6 5712.6 5469.0 5617.3 5627.9 5663.4 5663.7 5561.3 5655.3 5686.4 5690.7 5769.2 5524.3 5569.6 5574.7 5578.1 5590.2 03:03:38 INFO - PROCESS | 3453 | 03:03:38 INFO - PROCESS | 3453 | [#1] ext.html Cycles:180 Average:58711.47 Median:35459.88 stddev:121119.78 (341.6%) stddev-sans-first:121380.82 03:03:38 INFO - PROCESS | 3453 | Values: 545.6 558.3 568.4 587.9 601.1 40864.4 43107.8 43238.8 46560.8 46594.3 44143.6 44350.6 44486.6 44818.8 44918.0 8856.3 9036.0 9046.4 9057.0 10101.2 10158.2 10228.8 10250.8 10259.9 10267.3 10224.7 10258.8 10314.2 10335.9 10355.8 10269.9 10275.8 10305.1 10325.2 10334.5 10211.6 10223.7 10310.9 10326.4 10351.4 37792.4 38167.0 38356.4 38396.6 38555.4 3991.9 4009.8 4049.0 4112.3 4122.6 29251.7 29393.9 29643.6 29869.7 29964.7 3791.3 3809.3 3818.9 3840.1 3845.0 338827.0 338923.0 340359.0 340988.0 342359.0 51762.7 51848.0 51931.0 52033.5 52085.5 53735.7 53971.0 54041.5 54160.2 54244.2 15035.2 15527.1 15541.9 15559.5 15624.4 11718.8 11993.8 12010.6 12290.8 12399.5 16496.0 16637.8 16699.2 16729.4 16732.5 6600.1 6670.1 6787.2 6961.9 7059.9 895.1 911.3 911.5 913.7 919.8 26853.3 28774.9 29273.4 30085.8 30232.8 1047.5 1050.9 1060.9 1064.7 1065.8 14028.4 14191.4 14349.4 14375.2 14627.7 523791.0 530604.0 530831.0 531484.0 532922.0 47946.0 48425.5 48545.3 48550.0 48568.3 1377.8 1378.0 1392.4 1393.0 1405.4 26420.6 27200.9 27223.0 27309.1 28160.6 43356.0 44094.0 44114.3 44201.1 44238.8 470319.0 473668.0 476005.0 477196.0 478342.0 24394.8 25312.1 25599.0 25624.4 27108.5 38821.6 38893.4 39309.2 39763.4 39969.8 32695.0 35496.6 35529.3 35580.3 35640.0 34947.5 35160.8 35475.5 35546.6 35685.5 35140.0 35444.3 35997.0 36201.8 36827.6 30453.5 32710.7 32855.7 32929.8 33086.8 25730.6 25804.7 26110.2 26150.7 26214.7 03:03:38 INFO - PROCESS | 3453 | 03:03:38 INFO - PROCESS | 3453 | [#2] jquery.html Cycles:180 Average:28062.71 Median:22621.85 stddev:80936.31 (357.8%) stddev-sans-first:81136.71 03:03:38 INFO - PROCESS | 3453 | Values: 400.6 406.7 413.5 415.0 428.7 17434.7 18881.2 18954.4 18965.0 19074.5 18337.4 18734.6 18875.7 18912.4 18913.7 5200.3 5268.5 5368.7 5379.5 5422.9 5313.0 5368.8 5393.6 5401.2 5403.6 5318.0 5360.5 5753.2 5785.2 5795.1 5723.1 5733.8 5767.3 5770.8 5794.9 5021.6 5182.4 5234.1 5238.8 5241.9 13958.8 13966.8 14003.1 14096.6 14107.6 2693.8 2787.9 2795.4 2798.9 2967.9 10181.1 10280.4 10395.7 10840.2 10888.9 1946.8 2006.9 2017.4 2024.1 2025.9 54376.9 81448.0 81785.6 81968.6 83140.2 10364.4 10637.9 11027.5 11087.4 11124.2 12281.9 12895.6 15555.9 15636.5 15647.0 7857.3 7889.3 7902.2 7949.7 8050.4 7869.6 7872.6 8000.9 8045.3 8195.6 4111.5 4178.3 4182.5 4197.3 4293.7 1999.3 2024.8 2041.6 2054.4 2079.1 464.4 464.5 879.4 906.8 924.6 11335.2 11631.6 11879.8 11983.6 12229.9 493.9 495.2 496.2 498.7 498.9 6413.6 6434.0 6466.1 6606.0 6616.6 477005.0 477969.0 478981.0 503243.0 516005.0 86994.6 89465.6 91122.5 91319.5 92588.5 1055.7 1094.7 1105.7 1110.4 1110.7 16721.7 16882.4 16951.2 16970.2 17133.7 39396.0 39870.6 40092.0 40104.0 41132.2 54362.2 55660.0 55824.2 56739.0 57593.1 7640.9 7986.7 8464.3 8496.4 8756.6 12961.1 13438.3 13459.8 13536.9 13630.7 11401.8 11645.6 12068.3 12125.9 12219.6 11174.6 11518.8 11588.9 11666.6 12035.9 11668.4 11726.6 11974.6 12045.6 12107.4 8213.8 8513.2 8664.3 8778.5 8808.1 9948.5 11818.5 11857.2 11974.4 12102.0 03:03:38 INFO - PROCESS | 3453 | 03:03:38 INFO - PROCESS | 3453 | [#3] mootools.html Cycles:180 Average:5551.56 Median:5183.48 stddev:3102.95 (59.9%) stddev-sans-first:3095.76 03:03:38 INFO - PROCESS | 3453 | Values: 1372.6 1376.9 1382.4 1396.9 1406.8 7775.8 7958.5 8232.0 8567.0 8597.6 8194.6 8425.1 8425.4 8631.1 8665.7 2343.7 2363.8 2364.6 2383.3 2383.6 2297.2 2318.0 2349.9 2358.6 2377.2 2323.5 2336.7 2342.5 2342.7 2343.3 2259.4 2298.3 2304.5 2313.9 2316.1 2324.2 2326.8 2339.8 2346.3 2348.2 8602.1 8688.1 8768.8 8773.4 8780.6 5209.4 5318.2 5329.3 5345.3 5348.5 3182.8 3316.7 3392.2 3413.6 3418.8 1391.7 1396.9 1423.6 1465.9 1490.5 11814.5 11902.0 11906.3 11969.1 12000.8 4258.5 4541.2 4542.6 4626.8 4628.5 9613.9 9632.8 9635.9 9642.5 9646.5 5036.5 5157.5 5271.4 5292.2 5306.3 4592.7 4607.8 4639.7 4648.8 4708.8 3622.8 3646.1 3742.0 3761.5 3779.9 1139.7 1156.8 1171.3 1177.0 1177.0 804.8 827.3 828.6 830.2 831.8 5578.5 5602.5 5627.4 5784.1 5998.7 945.9 964.3 976.4 985.2 989.1 3582.6 3787.5 3802.3 3906.7 4025.0 10220.4 10431.2 10444.0 10497.9 10527.7 9592.9 10084.8 10375.3 10397.9 10457.6 7992.4 8145.0 8168.5 8184.3 8188.7 5916.4 5963.3 6079.2 6118.5 6280.8 8906.7 9502.0 9524.2 9530.2 9608.6 9313.9 9524.3 9534.3 9602.7 9635.6 6841.7 7487.1 7707.5 7708.6 7731.2 7746.9 7965.0 8087.8 8091.5 8108.2 7026.9 7121.7 7177.9 7233.1 7312.0 6858.3 7111.5 7211.1 7222.5 7280.5 5972.7 6011.0 6054.6 6102.1 6125.2 4781.2 4806.0 4836.5 4872.1 4930.9 4562.4 4614.4 4655.9 4763.3 4865.1 03:03:38 INFO - PROCESS | 3453 | 03:03:38 INFO - PROCESS | 3453 | [#4] prototype.html Cycles:180 Average:4743.27 Median:5411.27 stddev:1374.19 (25.4%) stddev-sans-first:1338.62 03:03:38 INFO - PROCESS | 3453 | Values: 389.3 401.9 405.2 406.7 414.3 5258.3 5332.8 5487.7 5514.4 5519.1 5304.2 5362.1 5381.9 5387.2 5435.4 4287.8 4300.3 4301.0 4307.4 4360.8 4002.2 4165.9 4322.5 4338.8 4360.4 4152.7 4154.3 4159.5 4159.6 4173.1 4170.7 4180.7 4189.9 4196.6 4231.7 3726.1 3748.4 3752.6 3754.5 3755.3 5163.4 5217.7 5250.3 5254.4 5293.4 4817.7 4850.7 4856.0 4863.3 4864.9 5511.5 5630.4 5676.8 5690.5 5698.6 4052.0 4082.0 4083.2 4099.3 4104.8 5915.2 5922.5 5929.9 5961.5 5963.4 4133.4 4211.9 4224.4 4228.8 4241.4 4205.3 4220.6 4245.6 4247.3 4247.4 4812.9 4815.8 4827.7 4832.1 4846.3 5608.4 5697.7 5705.8 5733.5 5763.8 1433.7 1434.3 1436.8 1436.9 1441.3 939.0 975.8 979.1 995.9 998.2 5211.3 5238.1 5267.8 5269.8 5272.7 5507.2 5541.4 5556.4 5572.0 5656.6 5128.6 5273.6 5318.3 5347.0 5348.8 2987.1 2989.7 3002.5 3012.8 3023.6 5662.8 5825.6 5850.4 5857.9 5909.7 5628.3 5680.8 5685.2 5701.4 5727.4 5834.0 5854.4 5869.5 5883.3 5891.6 5485.6 5587.6 5618.7 5646.2 5668.2 5515.3 5530.4 5531.2 5538.5 5626.4 5890.6 5892.2 5901.8 5903.3 5919.9 3877.0 4007.5 4063.8 4202.4 4212.6 5850.8 5856.0 5870.7 5876.4 5896.6 5625.5 5701.8 5710.9 5718.7 5755.4 5545.2 5699.6 5704.6 5729.3 5734.3 5622.6 5665.6 5675.7 5690.4 5699.5 5514.6 5647.5 5687.5 5708.5 5745.3 5509.2 5593.2 5598.4 5605.1 5615.4 03:03:38 INFO - PROCESS | 3453 | 03:03:38 INFO - PROCESS | 3453 | [#5] yui.html Cycles:180 Average:18465.96 Median:46203.77 stddev:23648.76 (51.2%) stddev-sans-first:23677.50 03:03:38 INFO - PROCESS | 3453 | Values: 705.7 757.3 764.7 766.8 787.4 16221.9 17279.9 17330.8 17343.9 17366.6 15753.2 15901.4 15914.4 15942.1 15960.5 693.8 715.3 784.6 799.1 812.9 826.4 832.3 832.5 832.9 833.2 874.8 878.3 879.1 879.3 880.4 859.2 861.1 869.8 869.8 870.9 635.1 636.5 640.3 641.2 642.0 15778.5 16164.5 16166.5 16555.9 16717.2 14524.6 14721.2 14847.3 15140.0 15218.7 11441.9 11699.5 11873.2 11942.9 12194.5 4391.1 4392.8 4416.3 4491.1 4529.1 79545.0 81581.6 82618.6 83094.6 83258.6 11313.2 11406.8 11431.3 11473.9 11499.8 22166.6 22483.0 22643.3 22704.2 22913.5 8264.6 8300.8 8335.7 8573.9 8700.0 4538.6 4648.9 4692.5 4729.4 4803.4 3714.7 3752.3 3768.4 3796.8 3802.7 650.7 656.0 662.6 666.8 674.9 726.2 736.3 745.2 758.1 782.3 9198.7 9248.0 9713.6 9868.1 10081.0 735.9 739.7 753.2 762.7 767.1 4221.4 4408.5 4509.8 4544.0 4569.3 77361.0 80756.2 82215.6 83414.0 86869.6 72596.3 72632.6 74384.0 76071.0 76161.0 64402.7 65261.7 66718.7 67757.7 69208.7 8594.6 8689.2 8876.8 9019.7 9033.6 44457.3 45535.3 45780.0 46082.8 46324.8 55613.4 57110.4 57520.7 57610.4 59239.4 12224.3 12319.4 12618.1 12867.9 13125.8 15436.6 15552.4 15650.5 15864.8 16684.5 12393.2 13272.8 15293.2 15295.0 15305.8 12459.7 14017.9 14409.2 14707.3 14733.6 14070.5 14199.5 14750.9 14763.7 15099.7 11764.3 11868.7 12374.3 12679.0 12769.9 11577.4 11580.4 11641.0 11675.7 11905.6 03:03:38 INFO - PROCESS | 3453 | -------- Summary: end -------- 03:03:38 INFO - PROCESS | 3453 | 03:03:39 INFO - TEST-INFO | 3453: exit 0 03:03:39 INFO - TEST-OK | dromaeo_css | took 1114734ms 03:03:39 INFO - TEST-START | kraken 03:03:39 INFO - operating with platform_type : linux_ 03:03:39 INFO - Initialising browser for kraken test... 03:03:39 INFO - TEST-INFO | started process 3801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHs4tkd/profile http://localhost:42003/getInfo.html) 03:03:40 INFO - PROCESS | 3801 | 1482750220186 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:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 03:03:43 INFO - PROCESS | 3801 | __metrics Screen width/height:1600/1200 03:03:43 INFO - PROCESS | 3801 | colorDepth:24 03:03:43 INFO - PROCESS | 3801 | Browser inner width/height: 1024/697 03:03:43 INFO - PROCESS | 3801 | __metrics 03:03:44 ERROR - PROCESS | 3801 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 03:03:45 INFO - TEST-INFO | 3801: exit 0 03:03:45 INFO - Browser initialized. 03:03:45 INFO - Running cycle 1/1 for kraken test... 03:03:45 INFO - TEST-INFO | started process 3924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHs4tkd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:03:56 INFO - PROCESS | 3924 | RSS: Main: 154230784 03:03:56 INFO - PROCESS | 3924 | 03:03:59 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42003/tests/kraken/driver.html?testName=audio-beat-detection) 03:04:00 INFO - PROCESS | 3924 | RSS: Main: 160702464 03:04:00 INFO - PROCESS | 3924 | 03:04:02 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42003/tests/kraken/driver.html?testName=audio-dft) 03:04:03 INFO - PROCESS | 3924 | RSS: Main: 160043008 03:04:03 INFO - PROCESS | 3924 | 03:04:06 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42003/tests/kraken/driver.html?testName=audio-fft) 03:04:06 INFO - PROCESS | 3924 | RSS: Main: 156119040 03:04:06 INFO - PROCESS | 3924 | 03:04:09 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42003/tests/kraken/driver.html?testName=audio-oscillator) 03:04:09 INFO - PROCESS | 3924 | RSS: Main: 156536832 03:04:09 INFO - PROCESS | 3924 | 03:04:11 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42003/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:04:12 INFO - PROCESS | 3924 | RSS: Main: 156667904 03:04:12 INFO - PROCESS | 3924 | 03:04:15 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42003/tests/kraken/driver.html?testName=imaging-darkroom) 03:04:16 INFO - PROCESS | 3924 | RSS: Main: 160460800 03:04:16 INFO - PROCESS | 3924 | 03:04:19 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42003/tests/kraken/driver.html?testName=imaging-desaturate) 03:04:20 INFO - PROCESS | 3924 | RSS: Main: 159911936 03:04:20 INFO - PROCESS | 3924 | 03:04:23 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42003/tests/kraken/driver.html?testName=json-parse-financial) 03:04:23 INFO - PROCESS | 3924 | RSS: Main: 159731712 03:04:23 INFO - PROCESS | 3924 | 03:04:25 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42003/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:04:25 INFO - PROCESS | 3924 | RSS: Main: 159977472 03:04:25 INFO - PROCESS | 3924 | 03:04:27 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42003/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:04:28 INFO - PROCESS | 3924 | RSS: Main: 160366592 03:04:28 INFO - PROCESS | 3924 | 03:04:30 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42003/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:04:31 INFO - PROCESS | 3924 | RSS: Main: 159686656 03:04:31 INFO - PROCESS | 3924 | 03:04:34 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:04:34 INFO - PROCESS | 3924 | RSS: Main: 159870976 03:04:34 INFO - PROCESS | 3924 | 03:04:37 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:04:38 INFO - PROCESS | 3924 | RSS: Main: 159944704 03:04:38 INFO - PROCESS | 3924 | 03:04:39 INFO - PROCESS | 3924 | Cycle 1(1): loaded http://localhost:42003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42003/tests/kraken/driver.html?testName=ai-astar) 03:04:40 INFO - PROCESS | 3924 | RSS: Main: 161628160 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | __start_tp_report 03:04:40 INFO - PROCESS | 3924 | _x_x_mozilla_page_load 03:04:40 INFO - PROCESS | 3924 | _x_x_mozilla_page_load_details 03:04:40 INFO - PROCESS | 3924 | |i|pagename|runs| 03:04:40 INFO - PROCESS | 3924 | |0;ai-astar;103;112;113;111;112;113;114;112;112;113 03:04:40 INFO - PROCESS | 3924 | |1;audio-beat-detection;142;126;121;174;120;123;121;121;144;120 03:04:40 INFO - PROCESS | 3924 | |2;audio-dft;162;162;163;162;162;161;162;169;163;161 03:04:40 INFO - PROCESS | 3924 | |3;audio-fft;86;78;78;97;76;76;74;76;104;76 03:04:40 INFO - PROCESS | 3924 | |4;audio-oscillator;83;84;103;87;88;86;105;85;83;105 03:04:40 INFO - PROCESS | 3924 | |5;imaging-gaussian-blur;117;120;118;118;117;117;117;118;118;117 03:04:40 INFO - PROCESS | 3924 | |6;imaging-darkroom;147;148;148;147;147;148;148;148;148;147 03:04:40 INFO - PROCESS | 3924 | |7;imaging-desaturate;97;97;96;97;96;96;96;95;96;96 03:04:40 INFO - PROCESS | 3924 | |8;json-parse-financial;56;56;55;58;58;63;57;58;62;57 03:04:40 INFO - PROCESS | 3924 | |9;json-stringify-tinderbox;67;68;68;68;69;66;69;70;67;68 03:04:40 INFO - PROCESS | 3924 | |10;stanford-crypto-aes;80;81;92;83;83;82;88;82;92;80 03:04:40 INFO - PROCESS | 3924 | |11;stanford-crypto-ccm;132;140;147;126;125;128;132;127;190;127 03:04:40 INFO - PROCESS | 3924 | |12;stanford-crypto-pbkdf2;171;175;166;165;169;165;166;166;165;170 03:04:40 INFO - PROCESS | 3924 | |13;stanford-crypto-sha256-iterative;66;64;63;64;63;67;66;63;65;64 03:04:40 INFO - PROCESS | 3924 | __end_tp_report 03:04:40 INFO - PROCESS | 3924 | __start_cc_report 03:04:40 INFO - PROCESS | 3924 | _x_x_mozilla_cycle_collect,727 03:04:40 INFO - PROCESS | 3924 | __end_cc_report 03:04:40 INFO - PROCESS | 3924 | __startTimestamp1482750280231__endTimestamp 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | ------- Summary: start ------- 03:04:40 INFO - PROCESS | 3924 | Number of tests: 14 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:3.10 (2.8%) stddev-sans-first:0.88 03:04:40 INFO - PROCESS | 3924 | Values: 103.0 112.0 113.0 111.0 112.0 113.0 114.0 112.0 112.0 113.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:124.50 stddev:17.54 (14.1%) stddev-sans-first:18.17 03:04:40 INFO - PROCESS | 3924 | Values: 142.0 126.0 121.0 174.0 120.0 123.0 121.0 121.0 144.0 120.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.31 (1.4%) stddev-sans-first:2.44 03:04:40 INFO - PROCESS | 3924 | Values: 162.0 162.0 163.0 162.0 162.0 161.0 162.0 169.0 163.0 161.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:10.35 (13.4%) stddev-sans-first:10.89 03:04:40 INFO - PROCESS | 3924 | Values: 86.0 78.0 78.0 97.0 76.0 76.0 74.0 76.0 104.0 76.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.50 stddev:9.42 (11.1%) stddev-sans-first:9.55 03:04:40 INFO - PROCESS | 3924 | Values: 83.0 84.0 103.0 87.0 88.0 86.0 105.0 85.0 83.0 105.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 03:04:40 INFO - PROCESS | 3924 | Values: 117.0 120.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 03:04:40 INFO - PROCESS | 3924 | Values: 147.0 148.0 148.0 147.0 147.0 148.0 148.0 148.0 148.0 147.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 03:04:40 INFO - PROCESS | 3924 | Values: 97.0 97.0 96.0 97.0 96.0 96.0 96.0 95.0 96.0 96.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:2.58 (4.5%) stddev-sans-first:2.64 03:04:40 INFO - PROCESS | 3924 | Values: 56.0 56.0 55.0 58.0 58.0 63.0 57.0 58.0 62.0 57.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 03:04:40 INFO - PROCESS | 3924 | Values: 67.0 68.0 68.0 68.0 69.0 66.0 69.0 70.0 67.0 68.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:4.64 (5.6%) stddev-sans-first:4.66 03:04:40 INFO - PROCESS | 3924 | Values: 80.0 81.0 92.0 83.0 83.0 82.0 88.0 82.0 92.0 80.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:132.00 stddev:19.76 (15.0%) stddev-sans-first:20.86 03:04:40 INFO - PROCESS | 3924 | Values: 132.0 140.0 147.0 126.0 125.0 128.0 132.0 127.0 190.0 127.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:167.50 stddev:3.36 (2.0%) stddev-sans-first:3.36 03:04:40 INFO - PROCESS | 3924 | Values: 171.0 175.0 166.0 165.0 169.0 165.0 166.0 166.0 165.0 170.0 03:04:40 INFO - PROCESS | 3924 | 03:04:40 INFO - PROCESS | 3924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:1.43 (2.2%) stddev-sans-first:1.41 03:04:40 INFO - PROCESS | 3924 | Values: 66.0 64.0 63.0 64.0 63.0 67.0 66.0 63.0 65.0 64.0 03:04:40 INFO - PROCESS | 3924 | -------- Summary: end -------- 03:04:40 INFO - PROCESS | 3924 | 03:04:41 INFO - TEST-INFO | 3924: exit 0 03:04:41 INFO - TEST-OK | kraken | took 61531ms 03:04:41 INFO - SUITE-END | took 1176s 03:04:41 INFO - Completed test suite (00:19:36) 03:04:41 INFO - javascript benchmark 03:04:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7078.311396347364, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.5344698295253, 3146.6224053113615, 3156.210947263184, 3200.951985720214, 3202.50361194015, 5209.0, 5363.544098751606, 5393.0, 5402.135658294674, 5419.918701219485, 5271.841844744664, 5356.839294821161, 5520.06158952978, 5524.309461317335, 5541.362743284523, 4804.83183088592, 4843.878903027417, 4846.466888642264, 4953.1332016896895, 4960.627952903546, 4767.284907263904, 4927.728974906378, 4930.260460930853, 4949.529794669518, 4950.925736113961, 4774.355462012619, 4813.350197723297, 4937.2840938063955, 4955.479674634147, 4970.13022721026, 4795.352627395292, 4805.255185446262, 4825.20384136617, 4891.8777030574165, 4936.8765780855765, 4839.128956787777, 4846.927296090562, 4853.781579828917, 4870.756462176877, 4887.951120488785, 5268.683878967274, 5321.840344789663, 5331.866703332447, 5369.5972802040005, 5404.243405923174, 5615.185798059259, 5665.12190610456, 5666.744996475128, 5690.9146362804595, 5779.739911703941, 5731.799387021476, 5738.081906894877, 5739.62692424991, 5743.253377060955, 5747.339056008529, 5344.385395679507, 5349.786008559653, 5353.812616558402, 5357.089294819929, 5390.676559406448, 5723.971380143073, 5780.150351887356, 5785.595008349375, 5799.623024503394, 5805.303363596311, 5606.635568688103, 5621.775128994795, 5644.97177514118, 5647.802326918621, 5676.4323567642905, 5654.547636189095, 5684.914726279109, 5739.081746920473, 5744.540436765049, 5753.741081651336, 5581.6930068845795, 5615.438456154434, 5699.401562835926, 5738.512226460714, 5776.133579963039, 5809.593328466966, 5810.593258471867, 5820.417958204146, 5822.155787410887, 5863.179154918314, 4352.2818734909015, 4362.411074504901, 4394.472663280363, 4407.933880991788, 4455.376247325377, 3835.194609132058, 3853.344931361675, 3878.8836334909997, 3897.590752970954, 3966.8809935701975, 5569.275994120739, 5569.526590239875, 5604.544387212176, 5615.101583746581, 5626.803061892814, 5796.0, 5848.590598658138, 5852.297724273029, 5863.941360586425, 5866.266716660418, 5283.339582552181, 5396.0, 5564.749586268627, 5582.358028826656, 5586.636868603528, 4798.47216806151, 4851.951480485221, 4855.8057677693205, 4872.366592342973, 4906.460289368167, 6031.09533569968, 6039.094135879565, 6041.8489537761025, 6065.939340606537, 6081.726322315506, 5611.971940140274, 5885.94114058871, 5886.352501224947, 5896.115582662464, 5902.203202567598, 5847.707614619167, 5854.414558544111, 5884.58807883444, 5888.528917686661, 5969.850753731192, 5624.268845050117, 5663.093904975184, 5674.829755107354, 5675.375708672125, 5677.687727175045, 5711.971440142773, 5728.627639203439, 5740.339860916049, 5759.8560035999435, 5765.106408506688, 5459.617826752089, 5511.641743286834, 5532.087205611029, 5571.637843540157, 5602.831915042555, 5646.265985421869, 5650.152477128464, 5652.293463317085, 5664.5751568631695, 5712.571557133315, 5469.0, 5617.32592088952, 5627.943720562742, 5663.3770285267765, 5663.66018038919, 5561.332640083216, 5655.321361436654, 5686.402927692533, 5690.658560486218, 5769.249997500298, 5524.33707955048, 5569.582281328835, 5574.665520068809, 5578.051731205624, 5590.161475778666], "value": 5304.472916873089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5690004896132, 558.3439458636104, 568.3747877334935, 587.8589138606735, 601.1403692719413, 40864.38703419447, 43107.78446107769, 43238.78380608092, 46560.76719616397, 46594.3119385301, 44143.55856441434, 44350.55649443505, 44486.555134448645, 44818.77590612043, 44918.0, 8856.291496680251, 9035.954820225923, 9046.416877046491, 9056.954715226415, 10101.242406819481, 10158.238132140119, 10228.846567301496, 10250.846237306447, 10259.948700256487, 10267.281290309682, 10224.74438139045, 10258.846117308247, 10314.226433017517, 10335.896641033607, 10355.844662330072, 10269.948650256776, 10275.794484110313, 10305.12406445453, 10325.173986081096, 10334.534945927413, 10211.591536338612, 10223.693289201336, 10310.896891031069, 10326.432046237529, 10351.430671313075, 37792.43311350332, 38167.0, 38356.424653630216, 38396.616033839586, 38555.42166867499, 3991.860284890044, 4009.848051528183, 4048.959510404917, 4112.321466957948, 4122.587741225883, 29251.707482925325, 29393.853030734925, 29643.55534666982, 29869.70130298691, 29964.70035299641, 3791.298609757204, 3809.3333666608232, 3818.909762858024, 3840.116773142165, 3844.9807750961345, 338827.0, 338923.0, 340359.0, 340988.0, 342359.0, 51762.741186293824, 51848.0, 51931.0, 52033.479665203624, 52085.47914520882, 53735.73132134314, 53971.0, 54041.45958540443, 54160.18759718607, 54244.18633720497, 15035.248237588077, 15527.146006969499, 15541.922290388702, 15559.533214003599, 15624.375024998873, 11718.765624687458, 11993.820092698617, 12010.63968080959, 12290.787658221427, 12399.504019839105, 16496.0, 16637.833621663627, 16699.165041747863, 16729.403178316476, 16732.498025059267, 6600.141981542369, 6670.132882725215, 6787.219469760942, 6961.93038069623, 7059.89410158848, 895.1138373010673, 911.252772726358, 911.4713466189594, 913.7487191022522, 919.8114386550741, 26853.328666783094, 28774.856125719238, 29273.414531709674, 30085.849570752005, 30232.84883575568, 1047.4657924458581, 1050.8844027157006, 1060.8726952765717, 1064.6752740414247, 1065.7602039541196, 14028.368723407471, 14191.422427524747, 14349.426022959173, 14375.209363484899, 14627.707445851023, 523791.0, 530604.0, 530831.0, 531484.0, 532922.0, 47946.0, 48425.5157448421, 48545.27182092201, 48550.0, 48568.27147592789, 1377.7864431013008, 1378.0, 1392.4012674549838, 1393.0248825821966, 1405.3956798576505, 26420.603690945034, 27200.863995679894, 27223.0, 27309.117276040695, 28160.577591336558, 43356.0, 44094.0, 44114.33828492511, 44201.11597768091, 44238.778806105765, 470319.0, 473668.0, 476005.0, 477196.0, 478342.0, 24394.75605243925, 25312.114076007252, 25599.0, 25624.359391015372, 27108.45783084288, 38821.61178388293, 38893.41659875161, 39309.21381572296, 39763.40354894737, 39969.80015100022, 32695.0, 35496.645033549335, 35529.289414212086, 35580.28839423249, 35640.0, 34947.47578786269, 35160.82419587886, 35475.46786798148, 35546.644533555365, 35685.46471802873, 35140.0, 35444.29111417705, 35997.0, 36201.818990904874, 36827.63172368242, 30453.54319685162, 32710.672893271716, 32855.67144328526, 32929.835350823094, 33086.83456582702, 25730.614040789776, 25804.741952580986, 26110.216693499224, 26150.73849261483, 26214.73785262123], "value": 19082.959530794382, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.5553835242882, 406.72952486596415, 413.4583695359079, 414.95435502094773, 428.6677824685868, 17434.73847892281, 18881.24475021001, 18954.431367058995, 18965.0, 19074.523136921584, 18337.449876503728, 18734.625307493843, 18875.716864247046, 18912.43262702121, 18913.7162942556, 5200.297959775438, 5268.473152684739, 5368.70472124033, 5379.466851947196, 5422.864428389283, 5312.973435132838, 5368.758405871745, 5393.622446428732, 5401.189821526783, 5403.621746477748, 5318.0, 5360.517553420192, 5753.223314852504, 5785.190073389729, 5795.130730390433, 5723.112917497794, 5733.770649174028, 5767.307923049261, 5770.826875193751, 5794.855128621797, 5021.598272138257, 5182.352205974254, 5234.0840352938085, 5238.842834714965, 5241.895162096775, 13958.790618140736, 13966.790498142536, 14003.089799163023, 14096.577102686935, 14107.647308817363, 2693.7844972402163, 2787.9442411151867, 2795.35706787438, 2798.860056997142, 2967.896123635662, 10181.08370246674, 10280.434576098312, 10395.740106497322, 10840.186985976005, 10888.891111088946, 1946.766388033445, 2006.8795872247713, 2017.3947815655392, 2024.1498570600384, 2025.939221823333, 54376.912461750544, 81448.0, 81785.59107204426, 81968.59015704943, 83140.16859831384, 10364.378137311785, 10637.9468102659, 11027.456156138147, 11087.390193539271, 11124.165687573464, 12281.93859030699, 12895.613131606067, 15555.911086224081, 15636.530904072668, 15647.0, 7857.2928436441, 7889.3294070004695, 7902.209779022167, 7949.682012719542, 8050.355971522265, 7869.606519673994, 7872.567008814455, 8000.8799868002025, 8045.275925166763, 8195.631196596167, 4111.527174374925, 4178.331466965271, 4182.519010313853, 4197.307444271661, 4293.720908141024, 1999.2502811445709, 2024.8154829424952, 2041.5712700333097, 2054.4247610669036, 2079.08520251089, 464.3893280336347, 464.4797826434415, 879.4371602174614, 906.7914379692708, 924.6347692661361, 11335.206535542598, 11631.59289424866, 11879.762404751857, 11983.64049078529, 12229.93885030569, 493.86418734848206, 495.2299174783175, 496.1738705056041, 498.7058582977169, 498.88026873550086, 6413.647249401234, 6433.967830160913, 6466.1270728452, 6606.0, 6616.636085015371, 477005.0, 477969.0, 478981.0, 503243.0, 516005.0, 86994.56502717445, 89465.55267223752, 91122.54438727896, 91319.54340228256, 92588.53705731429, 1055.678018204455, 1094.7099018759875, 1105.723569107723, 1110.4281295133012, 1110.6834552152598, 16721.66556668884, 16882.409115680894, 16951.237194326037, 16970.151492425084, 17133.74299385535, 39396.01509962274, 39870.60129398785, 40092.0, 40104.0, 41132.177356452106, 54362.18456723073, 55660.0, 55824.16263755965, 56739.0, 57593.13610295765, 7640.885386719315, 7986.720464783704, 8464.349451857075, 8496.362772791941, 8756.562171891508, 12961.09272350964, 13438.328083595976, 13459.79810302866, 13536.864631353954, 13630.659233519242, 11401.833651606168, 11645.59240426581, 12068.33624150645, 12125.878741212828, 12219.633410997329, 11174.608888688857, 11518.82721759191, 11588.88411115878, 11666.625015619144, 12035.879641203475, 11668.416579171177, 11726.589569365373, 11974.58088966882, 12045.578404755792, 12107.394630268627, 8213.79465513367, 8513.19124683154, 8664.263537599374, 8778.473291602524, 8808.119188081397, 9948.502574871372, 11818.468168932246, 11857.16999810005, 11974.401279936143, 12102.0], "value": 8544.827455900979, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.6499742565645, 1376.9311534423277, 1382.3710211853609, 1396.9371378287976, 1406.8311802583692, 7775.805604859881, 7958.522488650685, 8231.958840205798, 8566.999999999993, 8597.613107410167, 8194.631241594128, 8425.07324194338, 8425.36809739269, 8631.136886311366, 8665.653373865054, 2343.7304709958403, 2363.846349987254, 2364.574376612209, 2383.344580240439, 2383.559041577305, 2297.161536039342, 2317.9768202318014, 2349.89425475854, 2358.6344116661944, 2377.1561095811, 2323.477217626029, 2336.6845475860796, 2342.531493701258, 2342.6954495915506, 2343.2852979841227, 2259.435141214696, 2298.333483289844, 2304.5275718477674, 2313.90744370225, 2316.143027079974, 2324.151684635096, 2326.8371214015024, 2339.836211465198, 2346.2609278077352, 2348.2250857217077, 8602.09677983809, 8688.131186881325, 8768.780780480476, 8773.429727067783, 8780.604872780741, 5209.426963034063, 5318.175682769177, 5329.280547126127, 5345.278387417688, 5348.465153484659, 3182.793118447317, 3316.6849149330774, 3392.1858753899132, 3413.5903691556923, 3418.8290585470877, 1391.7286129204808, 1396.9092009019382, 1423.5800438870558, 1465.9486917957927, 1490.4932323010228, 11814.527418903233, 11902.047836173086, 11906.28562286257, 11969.102317326235, 12000.759984800256, 4258.510271318838, 4541.227991241497, 4542.613877820356, 4626.791794369262, 4628.467726211461, 9613.855792163124, 9632.807343853225, 9635.855462168072, 9642.469664168539, 9646.469444180497, 5036.546710795973, 5157.535821775983, 5271.3674359076385, 5292.2326262691695, 5306.257124002643, 4592.724436533818, 4607.838725644587, 4639.652026098056, 4648.814047438064, 4708.764561771966, 3622.836972336251, 3646.1431563582537, 3741.9625803741615, 3761.5110035695184, 3779.9433008504893, 1139.652406016173, 1156.7686462707493, 1171.344047333496, 1176.952921883115, 1176.988230117705, 804.8229389534293, 827.2637352756052, 828.5774255129807, 830.1781236575747, 831.8086840026707, 5578.497935185772, 5602.467765562265, 5627.437256274422, 5784.132380143013, 5998.700064996733, 945.8864936207561, 964.2816102004052, 976.4336684722844, 985.1822986920981, 989.1048601016092, 3582.570091588974, 3787.5454945406727, 3802.296575133609, 3906.687465002793, 4025.0, 10220.386776793268, 10431.16550675944, 10444.0, 10497.895021049844, 10527.736806579896, 9592.856107158399, 10084.848727269096, 10375.27373083892, 10397.896021039844, 10457.633982810565, 7992.3606111510935, 8144.959275203586, 8168.509889406655, 8184.304334131546, 8188.713395031145, 5916.437938395846, 5963.254593175853, 6079.240094988127, 6118.510519158545, 6280.842978925563, 8906.688265910661, 9501.952490237505, 9524.238060955246, 9530.1899338557, 9608.567614457506, 9313.906860931304, 9524.333296669167, 9534.332596718163, 9602.66390676323, 9635.614575416905, 6841.692123854339, 7487.138979017483, 7707.499012564165, 7708.576028318272, 7731.188225236494, 7746.922530774846, 7964.960175199087, 8087.757367278991, 8091.474054186459, 8108.189181081844, 7026.929730702627, 7121.679524421517, 7177.851543752974, 7233.0597022386755, 7312.049433573814, 6858.279880612663, 7111.466640002124, 7211.098612673416, 7222.494425390172, 7280.453965952469, 5972.671503067199, 6011.0, 6054.576179667381, 6102.115193296859, 6125.173101631222, 4781.211100168433, 4806.0, 4836.46798852133, 4872.074305881871, 4930.852074437773, 4562.406887104655, 4614.423197100363, 4655.906881862412, 4763.261694437368, 4865.1242776300605], "value": 4481.405949878164, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.2934324201574, 401.86135783154805, 405.2138850629778, 406.6726285340302, 414.3163779763392, 5258.316418865542, 5332.840014799563, 5487.670739755617, 5514.36584792749, 5519.11694128939, 5304.2043693446, 5362.115250983593, 5381.865453363668, 5387.171734839211, 5435.374931882835, 4287.82848686053, 4300.290452075419, 4301.0, 4307.396964424983, 4360.760158191299, 4002.2195671844, 4165.875023749277, 4322.487129504664, 4338.783060846961, 4360.389545463638, 4152.68854835887, 4154.273002224613, 4159.525082575862, 4159.604837540444, 4173.102782901676, 4170.666346692257, 4180.745776267138, 4189.916201675965, 4196.601322874322, 4231.746095234295, 3726.142987112979, 3748.4189950557707, 3752.605976372469, 3754.4743735877, 3755.267722794056, 5163.3545806774155, 5217.739113044333, 5250.291210686547, 5254.4220135785035, 5293.417724050351, 4817.710937343771, 4850.660453768238, 4856.0, 4863.294822250789, 4864.878378040542, 5511.53151982082, 5630.408807075239, 5676.801311954062, 5690.459406356389, 5698.629589076697, 4051.97974010131, 4082.0201253085415, 4083.203775263825, 4099.3031184698675, 4104.8152833122585, 5915.1551491530845, 5922.466977972003, 5929.881402371929, 5961.52307815378, 5963.4334738199805, 4133.42132101506, 4211.936820947688, 4224.408582798411, 4228.76741779199, 4241.367073676657, 4205.306124489425, 4220.6412454941055, 4245.596668316567, 4247.320428731388, 4247.3628955656895, 4812.927806082912, 4815.807367705253, 4827.662063655581, 4832.130216561053, 4846.29728689338, 5608.411116832755, 5697.686627235459, 5705.828825135252, 5733.512651424676, 5763.7982670606325, 1433.6630891740433, 1434.2756907761514, 1436.7988481612583, 1436.920969346696, 1441.322578388177, 938.9765255868658, 975.8438649816137, 979.128575567731, 995.915347195482, 998.1914649134225, 5211.348581427322, 5238.061917090701, 5267.762950667229, 5269.762860671279, 5272.657277276965, 5507.201455788968, 5541.390447050821, 5556.388797232301, 5572.024895643246, 5656.642405822655, 5128.6151140248, 5273.604479664041, 5318.282031925718, 5347.0, 5348.839534813962, 2987.1038688393396, 2989.7309242168308, 3002.5045867431627, 3012.834294113845, 3023.561583570414, 5662.8301150965535, 5825.611499285357, 5850.385709500526, 5857.882842343214, 5909.734061967221, 5628.324601047901, 5680.801171958961, 5685.232493613392, 5701.4013528579735, 5727.427257274323, 5833.970830145907, 5854.443827836349, 5869.530437564985, 5883.323417807007, 5891.558133139946, 5485.6434331768305, 5587.636803607753, 5618.719064046863, 5646.209530665628, 5668.234788303526, 5515.255440515479, 5530.364008138955, 5531.197976293334, 5538.529225015757, 5626.38109807929, 5890.611494436672, 5892.204552385373, 5901.7639294427745, 5903.284489135046, 5919.852003699942, 3876.96123038766, 4007.499062617173, 4063.756174629532, 4202.411662367333, 4212.578742125763, 5850.795222167204, 5856.0, 5870.706464676664, 5876.41235876409, 5896.557758168069, 5625.493705566519, 5701.831124619526, 5710.857228569319, 5718.742656580381, 5755.424457554211, 5545.195946587642, 5699.572532060195, 5704.629199102045, 5729.312482502127, 5734.34055083654, 5622.578306626938, 5665.603407761582, 5675.666218438746, 5690.430956904276, 5699.544036477155, 5514.648911016827, 5647.5481961442165, 5687.516561092188, 5708.514776244066, 5745.3105627324985, 5509.173623956439, 5593.244911936837, 5598.384177740527, 5605.075162598126, 5615.382307946041], "value": 4322.941245089147, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.7212401101568, 757.303280981497, 764.6826566974704, 766.7623036858571, 787.4055088408251, 16221.91889040556, 17279.913600432013, 17330.826691733095, 17343.913280433597, 17366.56583585408, 15753.212339383042, 15901.363945442168, 15914.363425462967, 15942.123183224947, 15960.521184364488, 693.7571849852561, 715.3454589051038, 784.5763287824568, 799.0810567846964, 812.8658771302743, 826.4380221449412, 832.3008672714918, 832.4838600067936, 832.8667413213886, 833.1918039501704, 874.8381549413347, 878.3368556739653, 879.1296616349831, 879.3229213505597, 880.4365206267994, 859.2138193552892, 861.0829466618063, 869.7695110795676, 869.8390797702414, 870.9259712924409, 635.0854769132435, 636.522608043967, 640.3308542573022, 641.2497378067673, 642.0465608571268, 15778.526644200692, 16164.515064547964, 16166.515004549765, 16555.91722041394, 16717.164141792862, 14524.56426307202, 14721.190334531597, 14847.331870065873, 15140.0, 15218.695626087527, 11441.885581144164, 11699.473523691455, 11873.16887817853, 11942.880571194351, 12194.451249693786, 4391.099824535962, 4392.846250381222, 4416.2713152329825, 4491.101779644052, 4529.116822219668, 79545.0, 81581.59209203917, 82618.58690706508, 83094.58452707698, 83258.58370708168, 11313.151513636345, 11406.771864562663, 11431.314121152758, 11473.942630286796, 11499.770004600028, 22166.556668866855, 22483.0, 22643.320700378685, 22704.205352812573, 22913.541729165325, 8264.586770661443, 8300.750977470685, 8335.708250211213, 8573.871391929126, 8700.0, 4538.636909047268, 4648.907021859543, 4692.53074692528, 4729.43246810385, 4803.423589169252, 3714.68425183857, 3752.3058234226755, 3768.378217594121, 3796.7911764853197, 3802.6957843372466, 650.6551527690332, 656.0487293424553, 662.5991275278484, 666.7632990288474, 674.922383925845, 726.1866709285529, 736.2674139231499, 745.2100773180446, 758.1470845299039, 782.307657722908, 9198.724038278862, 9248.0, 9713.61145554184, 9868.111869931741, 10081.042300981542, 735.9411247100326, 739.7004213293625, 753.2467532467532, 762.7254188492138, 767.0795045944889, 4221.387898754663, 4408.4930233023615, 4509.7970591323465, 4544.0457503924545, 4569.2689169732685, 77361.0, 80756.19243807605, 82215.588922055, 83414.0, 86869.56565217134, 72596.27403725895, 72632.63683681653, 74384.0, 76071.0, 76160.9999999989, 64402.677986609764, 65261.67369163124, 66718.66640666862, 67757.6612116946, 69208.65395672989, 8594.613242404232, 8689.17452841979, 8876.778080548038, 9019.729408117766, 9033.638654453749, 44457.33314000228, 45535.31697024614, 45780.0, 46082.76958615185, 46324.7683761579, 55613.443865560825, 57110.428895712175, 57520.71239643775, 57610.423895760505, 59239.40760592339, 12224.266544007389, 12319.384030798603, 12618.053645976404, 12867.935660322013, 13125.803112953123, 15436.614084647974, 15552.37790488413, 15650.530484085495, 15864.841351586336, 16684.49946501607, 12393.194442361219, 13272.80090798658, 15293.158876261912, 15295.0, 15305.770413443584, 12459.688507787378, 14017.929910350384, 14409.207493587954, 14707.338169782171, 14733.55799326022, 14070.507532236323, 14199.503017394341, 14750.926245369134, 14763.704725905636, 15099.698006040038, 11764.294142351486, 11868.703282418008, 12374.319412432402, 12679.049071319872, 12769.87230127724, 11577.421128943688, 11580.42097895085, 11641.0, 11675.677818690032, 11905.583304584645], "value": 7504.997529319255, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 111.0, 112.0, 113.0, 114.0, 112.0, 112.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 126.0, 121.0, 174.0, 120.0, 123.0, 121.0, 121.0, 144.0, 120.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 161.0, 162.0, 169.0, 163.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 78.0, 78.0, 97.0, 76.0, 76.0, 74.0, 76.0, 104.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 103.0, 87.0, 88.0, 86.0, 105.0, 85.0, 83.0, 105.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 58.0, 58.0, 63.0, 57.0, 58.0, 62.0, 57.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 69.0, 66.0, 69.0, 70.0, 67.0, 68.0], "value": 68.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 92.0, 83.0, 83.0, 82.0, 88.0, 82.0, 92.0, 80.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 140.0, 147.0, 126.0, 125.0, 128.0, 132.0, 127.0, 190.0, 127.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 175.0, 166.0, 165.0, 169.0, 165.0, 166.0, 166.0, 165.0, 170.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 63.0, 64.0, 63.0, 67.0, 66.0, 63.0, 65.0, 64.0], "value": 64.5, "unit": "score"}]}]} 03:04:41 INFO - Return code: 0 03:04:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:04:41 ERROR - # TBPL SUCCESS # 03:04:41 INFO - Running post-action listener: _resource_record_post_action 03:04:41 INFO - [mozharness: 2016-12-26 11:04:41.533824Z] Finished run-tests step (success) 03:04:41 INFO - Running post-run listener: _resource_record_post_run 03:04:41 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 9670656; Write bytes: 439918592; Read time: 1924; Write time: 354784 03:04:41 INFO - TinderboxPrint: CPU usage
13.4% 03:04:41 INFO - TinderboxPrint: I/O read bytes / time
9,670,656 / 1,924 03:04:41 INFO - TinderboxPrint: I/O write bytes / time
439,918,592 / 354,784 03:04:41 INFO - TinderboxPrint: CPU idle
8,247.4 (86.6%) 03:04:41 INFO - TinderboxPrint: CPU user
1,215.7 (12.8%) 03:04:41 INFO - TinderboxPrint: Swap in / out
0 / 0 03:04:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 131072; Write bytes: 107175936; Read time: 56; Write time: 67884 03:04:41 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 7409664; Write bytes: 332742656; Read time: 1748; Write time: 286900 03:04:42 INFO - Running post-run listener: _upload_blobber_files 03:04:42 INFO - Blob upload gear active. 03:04:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:04:42 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 03:04:42 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'] 03:04:42 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 03:04:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:04:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:04:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:04:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:43 INFO - (blobuploader) - INFO - Done attempting. 03:04:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:04:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:04:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:46 INFO - (blobuploader) - INFO - Done attempting. 03:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:04:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:47 INFO - (blobuploader) - INFO - Done attempting. 03:04:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:04:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:04:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:04:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:04:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:04:48 INFO - (blobuploader) - INFO - Done attempting. 03:04:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:04:48 INFO - Return code: 0 03:04:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:04:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:04:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b40f295ce219e2a35e1442ba0fc85e5fc905c02aa92436a01898402a9f35993238dab79d0fa57ad677fb3c85cecd526bdd5a34987b5583bb16dc5f179288e91a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32d5b2e6169f8d388f2148986a7c70bcd7f705d7fc1c68a913c12a691234865210471196b47af3522aa1bb30bac67fd394857d9d1cf25c4761ae0daf78ee8e79", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73a2dabf3a84b83792e5507c326ef6e03a02383648620a0539f56a78d2b07f9adb2ba70c5e38d177c76b1eae1021e8eccee10eced6c0012f17d0393051e32508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/839e44a94b56b925c04ec6f04e98e1c32c66006ca068dbb2c9bca175db9f72c15ac504467a21c79fa08a4e6e2d871e85ec441ce4fa33133946761d6edf683309"} 03:04:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:04:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:04:48 INFO - Contents: 03:04:48 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b40f295ce219e2a35e1442ba0fc85e5fc905c02aa92436a01898402a9f35993238dab79d0fa57ad677fb3c85cecd526bdd5a34987b5583bb16dc5f179288e91a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32d5b2e6169f8d388f2148986a7c70bcd7f705d7fc1c68a913c12a691234865210471196b47af3522aa1bb30bac67fd394857d9d1cf25c4761ae0daf78ee8e79", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73a2dabf3a84b83792e5507c326ef6e03a02383648620a0539f56a78d2b07f9adb2ba70c5e38d177c76b1eae1021e8eccee10eced6c0012f17d0393051e32508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/839e44a94b56b925c04ec6f04e98e1c32c66006ca068dbb2c9bca175db9f72c15ac504467a21c79fa08a4e6e2d871e85ec441ce4fa33133946761d6edf683309"} 03:04:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:04:48 INFO - Copying logs to upload dir... 03:04:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:04:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.601892 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-12-26 03:04:48.123869) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-26 03:04:48.129859) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105 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/b40f295ce219e2a35e1442ba0fc85e5fc905c02aa92436a01898402a9f35993238dab79d0fa57ad677fb3c85cecd526bdd5a34987b5583bb16dc5f179288e91a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32d5b2e6169f8d388f2148986a7c70bcd7f705d7fc1c68a913c12a691234865210471196b47af3522aa1bb30bac67fd394857d9d1cf25c4761ae0daf78ee8e79", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73a2dabf3a84b83792e5507c326ef6e03a02383648620a0539f56a78d2b07f9adb2ba70c5e38d177c76b1eae1021e8eccee10eced6c0012f17d0393051e32508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/839e44a94b56b925c04ec6f04e98e1c32c66006ca068dbb2c9bca175db9f72c15ac504467a21c79fa08a4e6e2d871e85ec441ce4fa33133946761d6edf683309"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482741002/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/b40f295ce219e2a35e1442ba0fc85e5fc905c02aa92436a01898402a9f35993238dab79d0fa57ad677fb3c85cecd526bdd5a34987b5583bb16dc5f179288e91a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32d5b2e6169f8d388f2148986a7c70bcd7f705d7fc1c68a913c12a691234865210471196b47af3522aa1bb30bac67fd394857d9d1cf25c4761ae0daf78ee8e79", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73a2dabf3a84b83792e5507c326ef6e03a02383648620a0539f56a78d2b07f9adb2ba70c5e38d177c76b1eae1021e8eccee10eced6c0012f17d0393051e32508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/839e44a94b56b925c04ec6f04e98e1c32c66006ca068dbb2c9bca175db9f72c15ac504467a21c79fa08a4e6e2d871e85ec441ce4fa33133946761d6edf683309"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-26 03:04:48.160794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 03:04:48.161334) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1482727098.463520-803064105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004326 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 03:04:48.248666) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-26 03:04:48.249495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-26 03:04:48.250185) ========= ========= Total master_lag: 0.20 =========