builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1482435203.16 results: success (0) buildid: 20161222112242 builduid: 96b0d8ba572847459a8e42c1a2d137fe revision: 9560724b684c145801e010d973dc43a33d6e9404 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:23.163157) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:23.163699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:23.164034) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:23.176595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:23.177042) ========= 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=836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-22 11:33:23-- 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% 39.5M=0s 2016-12-22 11:33:23 (39.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072793 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:23.267152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:23.268126) ========= 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=836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013160 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:23.323286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:23.324127) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9560724b684c145801e010d973dc43a33d6e9404 --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 9560724b684c145801e010d973dc43a33d6e9404 --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=836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-22 11:33:23,425 truncating revision to first 12 chars 2016-12-22 11:33:23,425 Setting DEBUG logging. 2016-12-22 11:33:23,425 attempt 1/10 2016-12-22 11:33:23,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9560724b684c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 11:33:23,744 unpacking tar archive at: mozilla-inbound-9560724b684c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:24.024813) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:24.025221) ========= script_repo_revision: 9560724b684c145801e010d973dc43a33d6e9404 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:24.025727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:24.026034) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 11:33:24.036608) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-22 11:33:24.036937) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:33:24 INFO - MultiFileLogger online at 20161222 11:33:24 in /builds/slave/test 11:33:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:33:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:33:24 INFO - {'append_to_log': False, 11:33:24 INFO - 'base_work_dir': '/builds/slave/test', 11:33:24 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:33:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:33:24 INFO - 'branch': 'Mozilla-Inbound', 11:33:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:33:24 INFO - 'config_files': ('talos/linux_config.py',), 11:33:24 INFO - 'default_actions': ('clobber', 11:33:24 INFO - 'read-buildbot-config', 11:33:24 INFO - 'download-and-extract', 11:33:24 INFO - 'populate-webroot', 11:33:24 INFO - 'create-virtualenv', 11:33:24 INFO - 'install', 11:33:24 INFO - 'run-tests'), 11:33:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:33:24 INFO - 'download_minidump_stackwalk': True, 11:33:24 INFO - 'download_symbols': 'ondemand', 11:33:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:33:24 INFO - 'tooltool.py': '/tools/tooltool.py', 11:33:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:33:24 INFO - '/tools/misc-python/virtualenv.py')}, 11:33:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:33:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:33:24 INFO - 'installer_path': 'installer.exe', 11:33:24 INFO - 'log_level': 'info', 11:33:24 INFO - 'log_name': 'talos', 11:33:24 INFO - 'log_to_console': True, 11:33:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:33:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:33:24 INFO - 'opt_config_files': (), 11:33:24 INFO - 'pip_index': False, 11:33:24 INFO - 'sps_profile': False, 11:33:24 INFO - 'sps_profile_interval': 0, 11:33:24 INFO - 'suite': 'dromaeojs', 11:33:24 INFO - 'system_bits': '32', 11:33:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:33:24 INFO - 'title': 'talos-linux64-ix-028', 11:33:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:33:24 INFO - 'use_talos_json': True, 11:33:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:33:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:33:24 INFO - 'work_dir': 'build'} 11:33:24 INFO - [mozharness: 2016-12-22 19:33:24.240394Z] Running clobber step. 11:33:24 INFO - Running pre-action listener: _resource_record_pre_action 11:33:24 INFO - Running main action method: clobber 11:33:24 INFO - rmtree: /builds/slave/test/build 11:33:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:33:25 INFO - Running post-action listener: _resource_record_post_action 11:33:25 INFO - [mozharness: 2016-12-22 19:33:25.208574Z] Finished clobber step (success) 11:33:25 INFO - [mozharness: 2016-12-22 19:33:25.208677Z] Running read-buildbot-config step. 11:33:25 INFO - Running pre-action listener: _resource_record_pre_action 11:33:25 INFO - Running main action method: read_buildbot_config 11:33:25 INFO - Using buildbot properties: 11:33:25 INFO - { 11:33:25 INFO - "project": "", 11:33:25 INFO - "product": "firefox", 11:33:25 INFO - "script_repo_revision": "production", 11:33:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 11:33:25 INFO - "repository": "", 11:33:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 11:33:25 INFO - "buildid": "20161222112242", 11:33:25 INFO - "stage_platform": "linux64-pgo", 11:33:25 INFO - "basedir": "/builds/slave/test", 11:33:25 INFO - "buildnumber": 3106, 11:33:25 INFO - "platform": "ubuntu64_hw", 11:33:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:33:25 INFO - "slavebuilddir": "test", 11:33:25 INFO - "branch": "mozilla-inbound", 11:33:25 INFO - "revision": "9560724b684c145801e010d973dc43a33d6e9404", 11:33:25 INFO - "slavename": "talos-linux64-ix-028", 11:33:25 INFO - "builduid": "96b0d8ba572847459a8e42c1a2d137fe", 11:33:25 INFO - "repo_path": "integration/mozilla-inbound" 11:33:25 INFO - } 11:33:25 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 11:33:25 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 11:33:25 INFO - Running post-action listener: _resource_record_post_action 11:33:25 INFO - [mozharness: 2016-12-22 19:33:25.211060Z] Finished read-buildbot-config step (success) 11:33:25 INFO - [mozharness: 2016-12-22 19:33:25.211150Z] Running download-and-extract step. 11:33:25 INFO - Running pre-action listener: _resource_record_pre_action 11:33:25 INFO - Running main action method: download_and_extract 11:33:25 INFO - mkdir: /builds/slave/test/build/tests 11:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:25 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:33:25 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:33:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:33:25 INFO - Downloaded 1361 bytes. 11:33:25 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 11:33:25 INFO - Using the following test package requirements: 11:33:25 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:33:25 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:33:25 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:33:25 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:25 INFO - u'jsshell-linux-x86_64.zip'], 11:33:25 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:33:25 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 11:33:25 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:33:25 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:33:25 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:33:25 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:33:25 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:33:25 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/1482428150/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:33:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:33:25 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:33:26 INFO - Expected file size: 21825777 11:33:26 INFO - Obtained file size: 21825777 11:33:30 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:33:30 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/1482428150/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 11:33:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:33:30 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:33:30 INFO - Expected file size: 21825777 11:33:30 INFO - Obtained file size: 21825777 11:33:35 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/1482428150/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 11:33:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:33:35 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:33:35 INFO - Expected file size: 14409776 11:33:35 INFO - Obtained file size: 14409776 11:33: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')]} 11:33:35 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:33:35 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:33:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:33:36 INFO - Downloaded 61327159 bytes. 11:33:36 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:33:36 INFO - mkdir: /builds/slave/test/properties 11:33:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:33:36 INFO - Writing to file /builds/slave/test/properties/build_url 11:33:36 INFO - Contents: 11:33:36 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 11:33:36 INFO - Running post-action listener: _resource_record_post_action 11:33:36 INFO - Running post-action listener: set_extra_try_arguments 11:33:36 INFO - [mozharness: 2016-12-22 19:33:36.922665Z] Finished download-and-extract step (success) 11:33:36 INFO - [mozharness: 2016-12-22 19:33:36.922832Z] Running populate-webroot step. 11:33:36 INFO - Running pre-action listener: _resource_record_pre_action 11:33:36 INFO - Running main action method: populate_webroot 11:33:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:33:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:33:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:33:36 INFO - '--tppagecycles', 11:33:36 INFO - '7'], 11:33:36 INFO - 'tests': ['tsvgm']}}, 11:33:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:33:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:33:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:33:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:33:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:33:36 INFO - 'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:33:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:33:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:33:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:33:36 INFO - 'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['damp', 'tps']}, 11:33:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:33:36 INFO - 'tests': ['damp', 'tps']}, 11:33:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['dromaeo_dom']}, 11:33:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:33:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['basic_compositor_video']}, 11:33:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:33:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['a11yr', 11:33:36 INFO - 'ts_paint', 11:33:36 INFO - 'tpaint', 11:33:36 INFO - 'sessionrestore', 11:33:36 INFO - 'sessionrestore_no_auto_restore', 11:33:36 INFO - 'tabpaint']}, 11:33:36 INFO - 'other-e10s': {'tests': ['a11yr', 11:33:36 INFO - 'ts_paint', 11:33:36 INFO - 'tpaint', 11:33:36 INFO - 'sessionrestore', 11:33:36 INFO - 'sessionrestore_no_auto_restore', 11:33:36 INFO - 'tabpaint']}, 11:33:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:33:36 INFO - 'ts_paint', 11:33:36 INFO - 'tpaint', 11:33:36 INFO - 'sessionrestore', 11:33:36 INFO - 'sessionrestore_no_auto_restore', 11:33:36 INFO - 'tabpaint']}, 11:33:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:33:36 INFO - 'ts_paint', 11:33:36 INFO - 'tpaint', 11:33:36 INFO - 'sessionrestore', 11:33:36 INFO - 'sessionrestore_no_auto_restore', 11:33:36 INFO - 'tabpaint']}, 11:33:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['a11yr', 11:33:36 INFO - 'ts_paint', 11:33:36 INFO - 'tpaint', 11:33:36 INFO - 'sessionrestore', 11:33:36 INFO - 'sessionrestore_no_auto_restore', 11:33:36 INFO - 'tabpaint']}, 11:33:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['a11yr', 11:33:36 INFO - 'ts_paint', 11:33:36 INFO - 'tpaint', 11:33:36 INFO - 'sessionrestore', 11:33:36 INFO - 'sessionrestore_no_auto_restore', 11:33:36 INFO - 'tabpaint']}, 11:33:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['tsvgx', 11:33:36 INFO - 'tsvgr_opacity', 11:33:36 INFO - 'tart', 11:33:36 INFO - 'tscrollx', 11:33:36 INFO - 'cart', 11:33:36 INFO - 'tsvg_static']}, 11:33:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:33:36 INFO - 'tsvgr_opacity', 11:33:36 INFO - 'tart', 11:33:36 INFO - 'tscrollx', 11:33:36 INFO - 'cart', 11:33:36 INFO - 'tsvg_static']}, 11:33:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:33:36 INFO - 'talos_options': ['--disable-e10s'], 11:33:36 INFO - 'tests': ['tp5o']}, 11:33:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:33:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:33:36 INFO - 'talos_options': ['--disable-e10s', 11:33:36 INFO - '--xperf_path', 11:33:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:33:36 INFO - 'tests': ['tp5n']}, 11:33:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:33:36 INFO - 'talos_options': ['--xperf_path', 11:33:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:33:36 INFO - 'tests': ['tp5n']}}, 11:33:36 INFO - 'talos.zip': {'path': '', 11:33:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:33:36 INFO - Running post-action listener: _resource_record_post_action 11:33:36 INFO - [mozharness: 2016-12-22 19:33:36.944421Z] Finished populate-webroot step (success) 11:33:36 INFO - [mozharness: 2016-12-22 19:33:36.944511Z] Running create-virtualenv step. 11:33:36 INFO - Running pre-action listener: _resource_record_pre_action 11:33:36 INFO - Running main action method: create_virtualenv 11:33:36 INFO - Creating virtualenv /builds/slave/test/build/venv 11:33:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:33:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:33:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:33:37 INFO - Using real prefix '/usr' 11:33:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:33:37 INFO - Installing distribute.............................................................................................................................................................................................done. 11:33:39 INFO - Installing pip.................done. 11:33:39 INFO - Return code: 0 11:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:33:39 INFO - Reading from file tmpfile_stdout 11:33:39 INFO - Output received: 11:33:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:33:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:33: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')]} 11:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33: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')]} 11:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:39 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 0x160a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, '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': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:33:39 INFO - Using env: {'DISPLAY': ':0', 11:33:39 INFO - 'HOME': '/home/cltbld', 11:33:39 INFO - 'LANG': 'en_US.UTF-8', 11:33:39 INFO - 'LANGUAGE': 'en_US:en', 11:33:39 INFO - 'LOGNAME': 'cltbld', 11:33:39 INFO - 'MAIL': '/var/mail/cltbld', 11:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:39 INFO - 'MOZ_NO_REMOTE': '1', 11:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:39 INFO - 'NO_EM_RESTART': '1', 11:33:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:39 INFO - 'PWD': '/builds/slave/test', 11:33:39 INFO - 'SHELL': '/bin/bash', 11:33:39 INFO - 'SHLVL': '1', 11:33:39 INFO - 'TERM': 'linux', 11:33:39 INFO - 'TMOUT': '86400', 11:33:39 INFO - 'USER': 'cltbld', 11:33:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:39 INFO - '_': '/tools/buildbot/bin/python'} 11:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:33:39 INFO - Cleaning up... 11:33:39 INFO - Return code: 0 11:33:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:33: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')]} 11:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33: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')]} 11:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:39 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 0x160a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, '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': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:33:39 INFO - Using env: {'DISPLAY': ':0', 11:33:39 INFO - 'HOME': '/home/cltbld', 11:33:39 INFO - 'LANG': 'en_US.UTF-8', 11:33:39 INFO - 'LANGUAGE': 'en_US:en', 11:33:39 INFO - 'LOGNAME': 'cltbld', 11:33:39 INFO - 'MAIL': '/var/mail/cltbld', 11:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:39 INFO - 'MOZ_NO_REMOTE': '1', 11:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:39 INFO - 'NO_EM_RESTART': '1', 11:33:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:39 INFO - 'PWD': '/builds/slave/test', 11:33:39 INFO - 'SHELL': '/bin/bash', 11:33:39 INFO - 'SHLVL': '1', 11:33:39 INFO - 'TERM': 'linux', 11:33:39 INFO - 'TMOUT': '86400', 11:33:39 INFO - 'USER': 'cltbld', 11:33:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:39 INFO - '_': '/tools/buildbot/bin/python'} 11:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:40 INFO - Downloading/unpacking psutil>=3.1.1 11:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:33:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:33:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:33:42 INFO - Installing collected packages: psutil 11:33:42 INFO - Running setup.py install for psutil 11:33:42 INFO - building 'psutil._psutil_linux' extension 11:33:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:33:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:33:42 INFO - building 'psutil._psutil_posix' extension 11:33:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:33:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:33:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:33:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:33:42 INFO - Successfully installed psutil 11:33:42 INFO - Cleaning up... 11:33:42 INFO - Return code: 0 11:33:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:33: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')]} 11:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33: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')]} 11:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:42 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 0x160a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, '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': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:33:42 INFO - Using env: {'DISPLAY': ':0', 11:33:42 INFO - 'HOME': '/home/cltbld', 11:33:42 INFO - 'LANG': 'en_US.UTF-8', 11:33:42 INFO - 'LANGUAGE': 'en_US:en', 11:33:42 INFO - 'LOGNAME': 'cltbld', 11:33:42 INFO - 'MAIL': '/var/mail/cltbld', 11:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:42 INFO - 'MOZ_NO_REMOTE': '1', 11:33:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:42 INFO - 'NO_EM_RESTART': '1', 11:33:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:42 INFO - 'PWD': '/builds/slave/test', 11:33:42 INFO - 'SHELL': '/bin/bash', 11:33:42 INFO - 'SHLVL': '1', 11:33:42 INFO - 'TERM': 'linux', 11:33:42 INFO - 'TMOUT': '86400', 11:33:42 INFO - 'USER': 'cltbld', 11:33:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:42 INFO - '_': '/tools/buildbot/bin/python'} 11:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:33: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 11:33: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 11:33: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 11:33: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 11:33: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 11:33: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 11:33:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:33:45 INFO - Installing collected packages: mozsystemmonitor 11:33:45 INFO - Running setup.py install for mozsystemmonitor 11:33:45 INFO - Successfully installed mozsystemmonitor 11:33:45 INFO - Cleaning up... 11:33:45 INFO - Return code: 0 11:33:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x160a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, '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': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:33:45 INFO - Using env: {'DISPLAY': ':0', 11:33:45 INFO - 'HOME': '/home/cltbld', 11:33:45 INFO - 'LANG': 'en_US.UTF-8', 11:33:45 INFO - 'LANGUAGE': 'en_US:en', 11:33:45 INFO - 'LOGNAME': 'cltbld', 11:33:45 INFO - 'MAIL': '/var/mail/cltbld', 11:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:45 INFO - 'MOZ_NO_REMOTE': '1', 11:33:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:45 INFO - 'NO_EM_RESTART': '1', 11:33:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:45 INFO - 'PWD': '/builds/slave/test', 11:33:45 INFO - 'SHELL': '/bin/bash', 11:33:45 INFO - 'SHLVL': '1', 11:33:45 INFO - 'TERM': 'linux', 11:33:45 INFO - 'TMOUT': '86400', 11:33:45 INFO - 'USER': 'cltbld', 11:33:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:45 INFO - '_': '/tools/buildbot/bin/python'} 11:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:45 INFO - Downloading/unpacking jsonschema==2.5.1 11:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:33:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:47 INFO - Downloading functools32-3.2.3-2.tar.gz 11:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:33:47 INFO - warning: no files found matching '*.txt' 11:33:47 INFO - no previously-included directories found matching 'build' 11:33:47 INFO - no previously-included directories found matching 'dist' 11:33:47 INFO - no previously-included directories found matching '.git*' 11:33:47 INFO - Installing collected packages: jsonschema, functools32 11:33:47 INFO - Running setup.py install for functools32 11:33:47 INFO - warning: no files found matching '*.txt' 11:33:47 INFO - no previously-included directories found matching 'build' 11:33:47 INFO - no previously-included directories found matching 'dist' 11:33:47 INFO - no previously-included directories found matching '.git*' 11:33:48 INFO - Successfully installed jsonschema functools32 11:33:48 INFO - Cleaning up... 11:33:48 INFO - Return code: 0 11:33:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x160a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, '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': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:33:48 INFO - Using env: {'DISPLAY': ':0', 11:33:48 INFO - 'HOME': '/home/cltbld', 11:33:48 INFO - 'LANG': 'en_US.UTF-8', 11:33:48 INFO - 'LANGUAGE': 'en_US:en', 11:33:48 INFO - 'LOGNAME': 'cltbld', 11:33:48 INFO - 'MAIL': '/var/mail/cltbld', 11:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:48 INFO - 'MOZ_NO_REMOTE': '1', 11:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:48 INFO - 'NO_EM_RESTART': '1', 11:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:48 INFO - 'PWD': '/builds/slave/test', 11:33:48 INFO - 'SHELL': '/bin/bash', 11:33:48 INFO - 'SHLVL': '1', 11:33:48 INFO - 'TERM': 'linux', 11:33:48 INFO - 'TMOUT': '86400', 11:33:48 INFO - 'USER': 'cltbld', 11:33:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:48 INFO - '_': '/tools/buildbot/bin/python'} 11:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:33:48 INFO - Cleaning up... 11:33:48 INFO - Return code: 0 11:33:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x160a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, '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': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:33:48 INFO - Using env: {'DISPLAY': ':0', 11:33:48 INFO - 'HOME': '/home/cltbld', 11:33:48 INFO - 'LANG': 'en_US.UTF-8', 11:33:48 INFO - 'LANGUAGE': 'en_US:en', 11:33:48 INFO - 'LOGNAME': 'cltbld', 11:33:48 INFO - 'MAIL': '/var/mail/cltbld', 11:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:48 INFO - 'MOZ_NO_REMOTE': '1', 11:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:48 INFO - 'NO_EM_RESTART': '1', 11:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:48 INFO - 'PWD': '/builds/slave/test', 11:33:48 INFO - 'SHELL': '/bin/bash', 11:33:48 INFO - 'SHLVL': '1', 11:33:48 INFO - 'TERM': 'linux', 11:33:48 INFO - 'TMOUT': '86400', 11:33:48 INFO - 'USER': 'cltbld', 11:33:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:48 INFO - '_': '/tools/buildbot/bin/python'} 11:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:48 INFO - Downloading/unpacking blobuploader==1.2.4 11:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:50 INFO - Downloading blobuploader-1.2.4.tar.gz 11:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:33:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:33:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:51 INFO - Downloading docopt-0.6.1.tar.gz 11:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:33:51 INFO - Installing collected packages: blobuploader, requests, docopt 11:33:51 INFO - Running setup.py install for blobuploader 11:33:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:33:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:33:51 INFO - Running setup.py install for requests 11:33:51 INFO - Running setup.py install for docopt 11:33:51 INFO - Successfully installed blobuploader requests docopt 11:33:51 INFO - Cleaning up... 11:33:52 INFO - Return code: 0 11:33:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:52 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 0x160a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, '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': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:33:52 INFO - Using env: {'DISPLAY': ':0', 11:33:52 INFO - 'HOME': '/home/cltbld', 11:33:52 INFO - 'LANG': 'en_US.UTF-8', 11:33:52 INFO - 'LANGUAGE': 'en_US:en', 11:33:52 INFO - 'LOGNAME': 'cltbld', 11:33:52 INFO - 'MAIL': '/var/mail/cltbld', 11:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:52 INFO - 'MOZ_NO_REMOTE': '1', 11:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:52 INFO - 'NO_EM_RESTART': '1', 11:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:52 INFO - 'PWD': '/builds/slave/test', 11:33:52 INFO - 'SHELL': '/bin/bash', 11:33:52 INFO - 'SHLVL': '1', 11:33:52 INFO - 'TERM': 'linux', 11:33:52 INFO - 'TMOUT': '86400', 11:33:52 INFO - 'USER': 'cltbld', 11:33:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:52 INFO - '_': '/tools/buildbot/bin/python'} 11:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:33:52 INFO - Running setup.py (path:/tmp/pip-24WIE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:33:52 INFO - Running setup.py (path:/tmp/pip-MBVNcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:33:52 INFO - Running setup.py (path:/tmp/pip-Bs3DSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:33:52 INFO - Running setup.py (path:/tmp/pip-fslVXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:33:52 INFO - Running setup.py (path:/tmp/pip-OUTax0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:33:52 INFO - Running setup.py (path:/tmp/pip-KSpGbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:33:52 INFO - Running setup.py (path:/tmp/pip-7jitwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:33:52 INFO - Running setup.py (path:/tmp/pip-41k5h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:33:52 INFO - Running setup.py (path:/tmp/pip-sS_w3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:33:52 INFO - Running setup.py (path:/tmp/pip-0VpWwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:33:52 INFO - Running setup.py (path:/tmp/pip-ienHgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:33:53 INFO - Running setup.py (path:/tmp/pip-C3QsYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:33:53 INFO - Running setup.py (path:/tmp/pip-rXrLZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:33:53 INFO - Running setup.py (path:/tmp/pip-lV4P3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:53 INFO - Running setup.py (path:/tmp/pip-Ho6tov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:33:53 INFO - Running setup.py (path:/tmp/pip-_nPs4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:33:53 INFO - Running setup.py (path:/tmp/pip-CVa9a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:33:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:33:53 INFO - Running setup.py install for manifestparser 11:33:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:33:53 INFO - Running setup.py install for mozcrash 11:33:53 INFO - Running setup.py install for mozdebug 11:33:53 INFO - Running setup.py install for mozdevice 11:33:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:33:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:33:53 INFO - Running setup.py install for mozfile 11:33:54 INFO - Running setup.py install for mozhttpd 11:33:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Running setup.py install for mozinfo 11:33:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Running setup.py install for mozInstall 11:33:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Running setup.py install for mozleak 11:33:54 INFO - Running setup.py install for mozlog 11:33:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Running setup.py install for moznetwork 11:33:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Running setup.py install for mozprocess 11:33:54 INFO - Running setup.py install for mozprofile 11:33:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Running setup.py install for mozrunner 11:33:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:33:54 INFO - Running setup.py install for mozscreenshot 11:33:55 INFO - Running setup.py install for moztest 11:33:55 INFO - Running setup.py install for mozversion 11:33:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:33:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:33:55 INFO - Cleaning up... 11:33:55 INFO - Return code: 0 11:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:55 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 0x160a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, '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': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:33:55 INFO - Using env: {'DISPLAY': ':0', 11:33:55 INFO - 'HOME': '/home/cltbld', 11:33:55 INFO - 'LANG': 'en_US.UTF-8', 11:33:55 INFO - 'LANGUAGE': 'en_US:en', 11:33:55 INFO - 'LOGNAME': 'cltbld', 11:33:55 INFO - 'MAIL': '/var/mail/cltbld', 11:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:55 INFO - 'MOZ_NO_REMOTE': '1', 11:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:55 INFO - 'NO_EM_RESTART': '1', 11:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:55 INFO - 'PWD': '/builds/slave/test', 11:33:55 INFO - 'SHELL': '/bin/bash', 11:33:55 INFO - 'SHLVL': '1', 11:33:55 INFO - 'TERM': 'linux', 11:33:55 INFO - 'TMOUT': '86400', 11:33:55 INFO - 'USER': 'cltbld', 11:33:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:55 INFO - '_': '/tools/buildbot/bin/python'} 11:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:33:55 INFO - Running setup.py (path:/tmp/pip-c3o_az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:33:55 INFO - Running setup.py (path:/tmp/pip-9yst84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:33:55 INFO - Running setup.py (path:/tmp/pip-FkoAkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:33:55 INFO - Running setup.py (path:/tmp/pip-UPKnNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:33:55 INFO - Running setup.py (path:/tmp/pip-eKp8ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:33:55 INFO - Running setup.py (path:/tmp/pip-jxCUf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:33:55 INFO - Running setup.py (path:/tmp/pip-RUMdhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:33:56 INFO - Running setup.py (path:/tmp/pip-i4Cc2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:33:56 INFO - Running setup.py (path:/tmp/pip-TK9uBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:33:56 INFO - Running setup.py (path:/tmp/pip-_V03Az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:33:56 INFO - Running setup.py (path:/tmp/pip-W44jO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:33:56 INFO - Running setup.py (path:/tmp/pip-wldWLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:33:56 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)) 11:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:33:56 INFO - Running setup.py (path:/tmp/pip-YnxxSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:33:56 INFO - Running setup.py (path:/tmp/pip-WPMBa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:56 INFO - Running setup.py (path:/tmp/pip-YgIlyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:33:56 INFO - Running setup.py (path:/tmp/pip-NxwBAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:33:56 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)) 11:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:33:56 INFO - Running setup.py (path:/tmp/pip-Yap7TD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:33:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:58 INFO - Downloading blessings-1.6.tar.gz 11:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:33:58 INFO - Installing collected packages: blessings 11:33:58 INFO - Running setup.py install for blessings 11:33:58 INFO - Successfully installed blessings 11:33:58 INFO - Cleaning up... 11:33:59 INFO - Return code: 0 11:33:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:33:59 INFO - Reading from file tmpfile_stdout 11:33:59 INFO - Current package versions: 11:33:59 INFO - argparse == 1.2.1 11:33:59 INFO - blessings == 1.6 11:33:59 INFO - blobuploader == 1.2.4 11:33:59 INFO - docopt == 0.6.1 11:33:59 INFO - functools32 == 3.2.3-2 11:33:59 INFO - jsonschema == 2.5.1 11:33:59 INFO - manifestparser == 1.1 11:33:59 INFO - mozInstall == 1.12 11:33:59 INFO - mozcrash == 1.0 11:33:59 INFO - mozdebug == 0.1 11:33:59 INFO - mozdevice == 0.49 11:33:59 INFO - mozfile == 1.2 11:33:59 INFO - mozhttpd == 0.7 11:33:59 INFO - mozinfo == 0.9 11:33:59 INFO - mozleak == 0.1 11:33:59 INFO - mozlog == 3.4 11:33:59 INFO - moznetwork == 0.27 11:33:59 INFO - mozprocess == 0.23 11:33:59 INFO - mozprofile == 0.28 11:33:59 INFO - mozrunner == 6.13 11:33:59 INFO - mozscreenshot == 0.1 11:33:59 INFO - mozsystemmonitor == 0.3 11:33:59 INFO - moztest == 0.7 11:33:59 INFO - mozversion == 1.4 11:33:59 INFO - psutil == 3.1.1 11:33:59 INFO - requests == 1.2.3 11:33:59 INFO - wsgiref == 0.1.2 11:33:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:59 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 0x160a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, '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': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:33:59 INFO - Using env: {'DISPLAY': ':0', 11:33:59 INFO - 'HOME': '/home/cltbld', 11:33:59 INFO - 'LANG': 'en_US.UTF-8', 11:33:59 INFO - 'LANGUAGE': 'en_US:en', 11:33:59 INFO - 'LOGNAME': 'cltbld', 11:33:59 INFO - 'MAIL': '/var/mail/cltbld', 11:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:59 INFO - 'MOZ_NO_REMOTE': '1', 11:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:59 INFO - 'NO_EM_RESTART': '1', 11:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:59 INFO - 'PWD': '/builds/slave/test', 11:33:59 INFO - 'SHELL': '/bin/bash', 11:33:59 INFO - 'SHLVL': '1', 11:33:59 INFO - 'TERM': 'linux', 11:33:59 INFO - 'TMOUT': '86400', 11:33:59 INFO - 'USER': 'cltbld', 11:33:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:59 INFO - '_': '/tools/buildbot/bin/python'} 11:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:33:59 INFO - Cleaning up... 11:33:59 INFO - Return code: 0 11:33:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, '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': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:33:59 INFO - Using env: {'DISPLAY': ':0', 11:33:59 INFO - 'HOME': '/home/cltbld', 11:33:59 INFO - 'LANG': 'en_US.UTF-8', 11:33:59 INFO - 'LANGUAGE': 'en_US:en', 11:33:59 INFO - 'LOGNAME': 'cltbld', 11:33:59 INFO - 'MAIL': '/var/mail/cltbld', 11:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:59 INFO - 'MOZ_NO_REMOTE': '1', 11:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:59 INFO - 'NO_EM_RESTART': '1', 11:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:59 INFO - 'PWD': '/builds/slave/test', 11:33:59 INFO - 'SHELL': '/bin/bash', 11:33:59 INFO - 'SHLVL': '1', 11:33:59 INFO - 'TERM': 'linux', 11:33:59 INFO - 'TMOUT': '86400', 11:33:59 INFO - 'USER': 'cltbld', 11:33:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:59 INFO - '_': '/tools/buildbot/bin/python'} 11:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:33:59 INFO - Cleaning up... 11:33:59 INFO - Return code: 0 11:33:59 INFO - Running post-action listener: _resource_record_post_action 11:33:59 INFO - Running post-action listener: _start_resource_monitoring 11:33:59 INFO - Starting resource monitoring. 11:33:59 INFO - [mozharness: 2016-12-22 19:33:59.738920Z] Finished create-virtualenv step (success) 11:33:59 INFO - [mozharness: 2016-12-22 19:33:59.739397Z] Running install step. 11:33:59 INFO - Running pre-action listener: _resource_record_pre_action 11:33:59 INFO - Running main action method: install 11:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:33:59 INFO - Reading from file tmpfile_stdout 11:33:59 INFO - Detecting whether we're running mozinstall >=1.0... 11:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:34:00 INFO - Reading from file tmpfile_stdout 11:34:00 INFO - Output received: 11:34:00 INFO - Usage: mozinstall [options] installer 11:34:00 INFO - Options: 11:34:00 INFO - -h, --help show this help message and exit 11:34:00 INFO - -d DEST, --destination=DEST 11:34:00 INFO - Directory to install application into. [default: 11:34:00 INFO - "/builds/slave/test"] 11:34:00 INFO - --app=APP Application being installed. [default: firefox] 11:34:00 INFO - mkdir: /builds/slave/test/build/application 11:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:34:17 INFO - Reading from file tmpfile_stdout 11:34:17 INFO - Output received: 11:34:17 INFO - /builds/slave/test/build/application/firefox/firefox 11:34:17 INFO - Running post-action listener: _resource_record_post_action 11:34:17 INFO - [mozharness: 2016-12-22 19:34:17.372723Z] Finished install step (success) 11:34:17 INFO - [mozharness: 2016-12-22 19:34:17.373021Z] Running run-tests step. 11:34:17 INFO - Running pre-action listener: _resource_record_pre_action 11:34:17 INFO - Running main action method: run_tests 11:34:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:34:17 INFO - Python 2.7.3 11:34:17 INFO - Return code: 0 11:34:17 INFO - grabbing minidump binary from tooltool 11:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:17 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 0x1a05850>, '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 0x197a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197ab60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:34:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:34:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:34:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:34:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:34:17 INFO - Return code: 0 11:34:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:34:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:34:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:34:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:34:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:34:17 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:34:17 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:34:17 INFO - Using env: {'DISPLAY': ':0', 11:34:17 INFO - 'HOME': '/home/cltbld', 11:34:17 INFO - 'LANG': 'en_US.UTF-8', 11:34:17 INFO - 'LANGUAGE': 'en_US:en', 11:34:17 INFO - 'LOGNAME': 'cltbld', 11:34:17 INFO - 'MAIL': '/var/mail/cltbld', 11:34:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:17 INFO - 'MOZ_NO_REMOTE': '1', 11:34:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:17 INFO - 'NO_EM_RESTART': '1', 11:34:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:17 INFO - 'PWD': '/builds/slave/test', 11:34:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:17 INFO - 'SHELL': '/bin/bash', 11:34:17 INFO - 'SHLVL': '1', 11:34:17 INFO - 'TERM': 'linux', 11:34:17 INFO - 'TMOUT': '86400', 11:34:17 INFO - 'USER': 'cltbld', 11:34:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453', 11:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:17 INFO - '_': '/tools/buildbot/bin/python'} 11:34:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:34:17 INFO - mozversion application_buildid: 20161222093550 11:34:17 INFO - mozversion application_changeset: 9560724b684c145801e010d973dc43a33d6e9404 11:34:17 INFO - mozversion application_display_name: Nightly 11:34:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:34:17 INFO - mozversion application_name: Firefox 11:34:17 INFO - mozversion application_remotingname: firefox 11:34:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:34:17 INFO - mozversion application_vendor: Mozilla 11:34:17 INFO - mozversion application_version: 53.0a1 11:34:17 INFO - mozversion platform_buildid: 20161222093550 11:34:17 INFO - mozversion platform_changeset: 9560724b684c145801e010d973dc43a33d6e9404 11:34:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:34:17 INFO - mozversion platform_version: 53.0a1 11:34:17 INFO - using testdate: 1482435257 11:34:17 INFO - actual date: 1482435257 11:34:17 INFO - starting webserver on 'localhost:56750' 11:34:17 INFO - SUITE-START | Running 2 tests 11:34:17 INFO - TEST-START | dromaeo_css 11:34:17 INFO - operating with platform_type : linux_ 11:34:17 INFO - Initialising browser for dromaeo_css test... 11:34:17 INFO - TEST-INFO | started process 11178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLJtxNp/profile http://localhost:56750/getInfo.html) 11:34:18 INFO - PROCESS | 11178 | 1482435258113 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 11:34:20 INFO - PROCESS | 11178 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 11:34:20 INFO - PROCESS | 11178 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 11:34:21 INFO - PROCESS | 11178 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 11:34:21 INFO - PROCESS | 11178 | __metrics Screen width/height:1600/1200 11:34:21 INFO - PROCESS | 11178 | colorDepth:24 11:34:21 INFO - PROCESS | 11178 | Browser inner width/height: 1024/697 11:34:21 INFO - PROCESS | 11178 | __metrics 11:34:21 INFO - PROCESS | 11178 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:34:21 INFO - PROCESS | 11178 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:34:22 INFO - PROCESS | 11178 | console.error: PushService: 11:34:22 INFO - PROCESS | 11178 | stateChangeProcessEnqueue: Error transitioning state 11:34:22 INFO - PROCESS | 11178 | UnknownError 11:34:23 INFO - TEST-INFO | 11178: exit 0 11:34:23 INFO - Browser initialized. 11:34:23 INFO - Running cycle 1/1 for dromaeo_css test... 11:34:23 INFO - TEST-INFO | started process 11262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLJtxNp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:35 INFO - PROCESS | 11262 | RSS: Main: 146829312 11:34:35 INFO - PROCESS | 11262 | 11:35:26 INFO - PROCESS | 11262 | 1482435326055 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:37:36 INFO - PROCESS | 11262 | Cycle 1(1): loaded http://localhost:56750/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56750/tests/dromaeo/cssquery-ext.html) 11:37:37 INFO - PROCESS | 11262 | RSS: Main: 314687488 11:37:37 INFO - PROCESS | 11262 | 11:39:24 INFO - PROCESS | 11262 | ************************* 11:39:24 INFO - PROCESS | 11262 | A coding exception was thrown and uncaught in a Task. 11:39:24 INFO - PROCESS | 11262 | 11:39:24 INFO - PROCESS | 11262 | Full message: ReferenceError: fetch is not defined 11:39:24 INFO - PROCESS | 11262 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 11:39:24 INFO - PROCESS | 11262 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 11:39:24 INFO - PROCESS | 11262 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 11:39:24 INFO - PROCESS | 11262 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:39:24 INFO - PROCESS | 11262 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:39:24 INFO - PROCESS | 11262 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:39:24 INFO - PROCESS | 11262 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 11:39:24 INFO - PROCESS | 11262 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:39:24 INFO - PROCESS | 11262 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:39:24 INFO - PROCESS | 11262 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:39:24 INFO - PROCESS | 11262 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 11:39:24 INFO - PROCESS | 11262 | 11:39:24 INFO - PROCESS | 11262 | ************************* 11:40:40 INFO - PROCESS | 11262 | Cycle 1(1): loaded http://localhost:56750/tests/dromaeo/cssquery-ext.html (next: http://localhost:56750/tests/dromaeo/cssquery-jquery.html) 11:40:40 INFO - PROCESS | 11262 | RSS: Main: 243093504 11:40:40 INFO - PROCESS | 11262 | 11:43:42 INFO - PROCESS | 11262 | Cycle 1(1): loaded http://localhost:56750/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56750/tests/dromaeo/cssquery-mootools.html) 11:43:43 INFO - PROCESS | 11262 | RSS: Main: 211062784 11:43:43 INFO - PROCESS | 11262 | 11:46:45 INFO - PROCESS | 11262 | Cycle 1(1): loaded http://localhost:56750/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56750/tests/dromaeo/cssquery-prototype.html) 11:46:46 INFO - PROCESS | 11262 | RSS: Main: 184205312 11:46:46 INFO - PROCESS | 11262 | 11:49:49 INFO - PROCESS | 11262 | Cycle 1(1): loaded http://localhost:56750/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56750/tests/dromaeo/cssquery-yui.html) 11:49:49 INFO - PROCESS | 11262 | RSS: Main: 184602624 11:49:49 INFO - PROCESS | 11262 | 11:52:52 INFO - PROCESS | 11262 | Cycle 1(1): loaded http://localhost:56750/tests/dromaeo/cssquery-yui.html (next: http://localhost:56750/tests/dromaeo/cssquery-dojo.html) 11:52:52 INFO - PROCESS | 11262 | RSS: Main: 275312640 11:52:52 INFO - PROCESS | 11262 | 11:52:52 INFO - PROCESS | 11262 | __start_tp_report 11:52:52 INFO - PROCESS | 11262 | _x_x_mozilla_page_load 11:52:52 INFO - PROCESS | 11262 | _x_x_mozilla_page_load_details 11:52:52 INFO - PROCESS | 11262 | |i|pagename|runs| 11:52:52 INFO - PROCESS | 11262 | |0;dojo.html;3045.19302384868;3074;3090.8145511269317;3124.047165614487;3138.6547479777237;5196.844094677156;5205.115130427826;5254.395744489375;5324.387695415028;5374.731263436827;5253.0544501989725;5312.442193569677;5324.600654950875;5332.866678333044;5379.273798037264;4803;4849.757512124397;4877.317175595419;4878.365812444377;4935.555799978001;4886.560209581137;4929.827456039039;4958.206686930092;4960.578350840183;5007.524285192901;4885.584725298354;4925.33507976424;4936.185529387647;4940.456549779521;4955.752212389384;4685.765711714401;4707.976460117712;4715.033418149305;4780.020095880336;4780.282957556359;4792;4832.685875418087;4833.468318484964;4835.323054772335;4860.125177468054;5316.38861530925;5318.149096144637;5324.760385782649;5327.334083239595;5328.20076988451;5695.686737229451;5695.943040569583;5701.2018317435595;5711.685857277848;5756.424357564252;5555.861103472405;5569.582281328917;5601.663900165962;5604.8038318658655;5696.572757043197;5315.229291752674;5318.97340513295;5344.7862085516535;5358.892822143535;5362.839114826562;5763.221965034667;5768.278965129359;5820.30156381237;5830.883382332329;5831.3877042910735;5473.616846820764;5502.284702988586;5589.80435684749;5603.775848966077;5605.075162598126;5674.971625141848;5704;5705.657660540381;5713.114467257582;5811.622244554175;5621.297337832771;5644.294463192101;5671.404502527175;5671.404502527258;5716.942830571724;5598.524125449301;5681.062624666966;5696.857578560569;5705.74324155414;5756.7121643917635;4176.0395109125075;4276.230278549829;4278.144371125787;4291.592298731678;4335.154644844225;3774.245150969817;3784.735068545175;3804.2011177653003;3817.10298079951;3859.2474467479133;5386.569074474032;5416.674999500043;5420.593455490775;5420.593455490854;5432.375276843135;5766.942330576724;5772.278465191851;5788.160716696139;5788.594798364158;5813.215215945793;5212.478752124757;5253.894922101613;5313.123334649817;5364.490373414519;5376.758045887945;4761.4524329701835;4766.404199475066;4772.331873537708;4805.8558243252755;4806.879828004258;5961.552883533665;5968.9701551492835;5972.044472884318;5977.9402205977385;5986.760529578768;5645.71771411436;5689.573282003784;5707.1153971134545;5735.168400581976;5743.856403589776;6000.069989151689;6017.368176341596;6030.246219222598;6064.605800622945;6090.208272924491;5633.352164501135;5645.943540564706;5674.858128546819;5684.261046063985;5687.77248910039;5581.553475721851;5606.299212598426;5627.043402621646;5773.797917072882;5787.768489260382;5577.972110139585;5580.35825880029;5581.581381396492;5585.916211256916;5588.77644894216;5525.171224316385;5542.695151766691;5581.944180558143;5590.5527557796095;5597.720113994203;5469.453054694499;5498;5514.310711161105;5529.115341545334;5591.245181900554;5572.777088916398;5578.748956297058;5586.413426590312;5588.916166257591;5606.411326810789;5442.428545002717;5456.645318054314;5457.672539647634;5465.125579907196;5512.090505066619 11:52:52 INFO - PROCESS | 11262 | |1;ext.html;534.4161253465284;579.368488347701;592.4194289596198;597.7519329478266;604.9001914684077;33073.834630826845;43406;44382;44455.10945803406;44467.11065778683;45630.31554526685;46081;46108;46131.30803037957;46154.538454615446;8215.137410571893;8848.5575721214;9028.187463128317;9031.638734450615;9033.864492032624;8266.421350505467;10417.53121109548;10635.308704934194;10684.412357320345;11041.944790276037;10747.032767050963;10818.188635852302;10818.350898946088;10818.513166907507;10825.67522974312;10766.138708903309;10819.67540973772;10830.350178989207;10840.891591084146;10843.783124337508;10559.26085174038;10625.149988000941;10627.14982801374;10632.415217163052;10634.893651063468;43076.35385469221;43380.56619433797;43460;43467.782661086494;43473.347899781525;3277.672232776727;3382.932341353184;3439.724822014233;3583.229605634775;3643.034595832107;27030.32424189391;29431.11706648804;29601.555976660366;29639.25901852471;29673.40653186924;4085.632293093636;4192.434021407102;4213.810378532943;4267.509236437819;4409.294512877957;362830;362930.22418654966;363666.9999999974;364383.17808411055;364969;52324.476755232725;52423.73788131035;52755.47244527505;52850.73574632179;52869.47130528645;55569.33168019864;56154.719226403606;56179.71910140423;56214.71892640593;56303.43696563064;15276.541703748906;15801;15812.209389530477;15829.683406332038;15844.76232856508;11295;11344.262622929484;12113.576024839089;12201.938990305169;12298.20061695987;16489.505314840575;17229.7415538767;17320.307187712602;17366.47900562985;17385.217665205095;6602.86794264112;6616.966915165393;6648.135742353463;6701.29636388182;6914.239433662293;955.6846240740539;1078.5955266774959;1111.9888801112047;1144.6566030190909;1156.392893730798;31845.363092738015;32239.838800805846;32353.676463235537;32672.673273266962;33339.333213335594;1094.8576685030896;1101.9944900275448;1116.6761639124725;1125.139268459629;1132.1282612388416;15933.36266549325;16961.745573816403;16962.830371696124;16969.0667013313;17280.22238999248;583699;585008;587834;591400;593177;58966.70516647389;59645;59699.40300596938;59855.40144598585;59870;1371.5748118083427;1397.6925076483158;1403.2422491854284;1408.6196726883684;1424.181095869879;30637.846810765805;31153.376932461677;31457.52813707842;31745.523817143225;32270.35459290848;52219.73890130525;52496;52522;52605;52680.20979685231;461191;462285;463357;464456;465241;28396.290092747848;28775.136745897657;28827.279318017216;28833.855830720713;28870.133895983156;40827.7958610205;45575.77212113918;45975.77012114918;50199.74900125622;51220.231696523835;39529.604703952595;40311.89511703513;40510.59489405068;41037;42179.367309491;39516.80241598774;39754.40368394534;40012.199756004135;40980;41253;39993.60006399899;40381;40759.59240407558;40865;41439.58560414357;33854.830725846216;36144.638553614124;36785.448218277284;36788;36844.81577592095;27462.5880611787;27786;27901.720982789913;27995;28030 11:52:52 INFO - PROCESS | 11262 | |2;jquery.html;390.377348129733;396.74608250719547;407.3360422511306;409.25719818529365;428;13457.192568445887;15424.305906234218;18060.187291571878;18298.634027319447;18744.90627546864;18374.265029398808;18625.441236762887;18661.720074198896;18802.529936751587;18802.905985470054;5516.200150978116;5522.254495643077;5732.742026608792;5733.283339582552;5733.426657334254;5568.2181701855425;5646.124850648135;5693.231413759152;5708.1437784332265;5717.113847353646;5390.5418039466695;5673.177389278552;5679.091345384739;5681.147827825838;5682.232898558704;5588.720563971785;5734.197212390269;5741.712914354286;5742.827715168552;5752.338481074647;5520.392756796749;5571.832845014656;5593.888122237573;5752.395998420189;5788.82633520995;13547.796783048263;13630.386632601556;13637.522686705917;13811.585652430444;13830.446782128703;2088.2691058129685;2150.8386870984737;2210.8452408331423;2382.404398900275;2620.5021046001198;9131.36080474367;9872.90127098727;9919.3056486046;9932.424327242186;10463.84304235437;1949.7952714964865;1950.1809240119042;2000.109951071759;2024.7975202479633;2045.9795402046086;71903;73702.26297737008;74022.25977740207;74428.62785686037;76570.61714691446;10748.731281718019;10759.83860242097;10963.616273430393;11101.44492775358;11107.777844443228;15083.54749357521;15089.54731358061;15091.320890559951;15122.697546049238;15135.772963405558;7685.615719214017;8127.187281271944;8128.187181281824;8368.163183681583;8375.916240837636;7763.650635721406;7764;7775.261350171838;7907.446478746548;8012.3590112790835;4610.101030299126;4663.48701642819;4697.506761790031;4760.928586071212;4808.9519104808505;1928.8595891948082;1933.9033048347808;1998.8906157082668;2007.5081605006867;2053.363457328233;922.6770630279349;931.8182954323842;993.3642468819961;1021.1830535571513;1075.800976819291;17358.479245622653;18427.26290948374;18706.71939920902;18777.718334225;18949.62100757977;927.7773334399695;935.3826474526779;963.4700914496999;984.6799790068256;993.761497240657;7751.92248077512;10092.495375231209;10537.262391632512;10539;10605.84091238632;394486;396783;401459;403695;404195;53216;55492.84368079303;79961.60019199867;83281;85974.14025859786;941.6374695742052;953.6995846308529;991.6430085169477;991.74214704176;992.3500107429645;16484.34062637529;16659.583510412336;16827.579310516845;16971.066591337596;17116.743248851028;37946.43080353742;39260;39305.41041884317;39585.2082958345;39978.400323995746;52189.7390513045;52338.47661523336;52572.21141682801;53792.462075378746;54229;7412.8146796328365;7736.994190755166;8201.384896132933;8364.330853531581;8540.786480338042;12298;12760;12908.870911291142;13138.73722525525;13211.735765284448;10956;11188.440577971232;11344.319340839576;11499.195056345976;11640;10889.237753357189;10991.945040274748;11085.390303533382;11196.776064478501;11708.356040417859;11211.55153793839;11382.487788049391;11420.257683250562;11516.120969757561;11652.825207621723;7402.703891844266;7679.232076792276;7767.844643106993;7874.251946065115;8069.072056713553;8968;10530.210234232616;11124;11162.832557511807;11411.201215914807 11:52:52 INFO - PROCESS | 11262 | |3;mootools.html;1428.5428662827892;1438.8633079857414;1590.6341541445468;1685.772420723202;1752.4217008387234;7744.961275193623;8105.189481051899;8110.878336824952;8137.471064380811;8151.266386025257;7302.561846289226;7502;7752.147263800977;8003.159668234839;8058.073321568021;2218.7004754358195;2247.516783891463;2248.3704562722464;2254.413852398372;2257.1535674122206;2269.1263863412623;2299.4366380236866;2332.941676458085;2334.1013709721797;2341.8594884306913;2275.2719129878446;2278.1798552521077;2278.4303924018996;2298.9540209195807;2305.5158416732506;2239.518503521734;2255.6842042114117;2273.0453209651987;2273.1702928431087;2277.6241920083166;2233.7654546272734;2254.3800454874877;2260.107257633242;2260.378395941113;2261.536385041079;8083.232092951161;8091.433599648027;8190.058143313536;8195.303399211074;8200.548969806658;4854.2718592211095;4952.405711314629;4989.151844186497;4989.750512474362;4992.450830408652;2980.687027862065;3055.5263934090253;3279.918002049944;3285.195127193853;3300.1584595927884;960.6685693435824;966.9033096690345;975.6000039983644;984.458547798715;1010.6765834932825;10983.505742241618;10985.890141098567;10989.670309890716;10992.615258465996;11019.393933333664;4167.395727619478;4399.23013472641;4447.132809102194;4449.377087207794;4476.619487343547;9489.240860731124;9490.383125096847;9491.90508094924;9491.952540237255;9493.525323733924;5034.622403319766;5040.949590504121;5043.722595257296;5044.974775126174;5050.873728156752;4466.454121150978;4525.796339164745;4630.398048253705;4631.907361852744;4646.233371493733;3817.751846129993;3869.941950870739;3882.2235552889533;3962.2867883781196;4092.9386059209137;1265.8354413926131;1291.141390974991;1297.7599144158362;1305.549585393038;1311.8819306262483;790.561238512631;846.7798372423214;877.8727084572702;906.0622255965045;916.1251005289932;5426.8371948841595;5443.2107344434835;5532.1425179097305;5616.97191514048;5707.1153971134545;891.4695756025154;955.6273053509137;958.1616085924816;982.3320142303303;1062.3360399750156;3565.3938830398893;3777.338965680995;3796.487474191004;3799.1072098056934;3937.114149316381;9733.853992190123;10035.548400322003;10039.14667253277;10043.4476103815;10050.346727462691;9628.374155679858;9762.560684769202;9865.556049977768;9966.80066398668;10001.099901008944;7598.240175982358;7679.462437629312;7695;7704.383649308042;7728.18854020331;5451.972740136274;5460.453954604508;5515.393306736176;5534.169874518854;5584.664920104807;8969.641214351353;8981.595828187877;9037.005929347635;9046.819063618823;9140.131687489678;8842.823143536965;9050.954745226232;9099.317551183556;9341.346105772802;9438.622455101719;6994.055802466602;7139.286071392819;7142.678579463833;7142.9285707144345;7143.1428228612895;7921.049474063149;7951.324137448381;8000.51996880189;8005.319547838266;8007.599620019092;7068.611226382598;7100.502964792415;7214.819629509304;7223.422126229994;7370.852582948418;7032.050673159058;7113.608751518716;7128.821779455555;7139.143302803489;7150.427965762622;5915.615484993462;6004.39956004396;6036.939630603638;6081.057436097412;6166.105914642441;4290.50659174199;4363.280058790264;4429.756363399915;4464.084862603094;4639.2113340731485;4485.282354823213;4503.414556107816;4577.153226653079;4621.191291523903;4642.234031384919 11:52:52 INFO - PROCESS | 11262 | |4;prototype.html;347.461434776097;385.72613444454436;387.86424751337034;388.80365415465184;399.8360672124428;5078.492150784924;5208.38540052583;5231.424543300239;5241.187615919529;5325.3077099977045;5214.973925130378;5240.37115546134;5265.419944227329;5319.7340132993295;5327.334083239595;4220.36694495825;4222.429971953793;4234.322508398657;4236.449261595988;4260.957390426102;4031.2945234583976;4067.430559721641;4131.752094874302;4170.186813571355;4230.757698419827;4190.9580904191025;4192.37114432836;4199.7690127043;4202.474690663667;4222.746635201883;4202.747835129902;4206.221848957953;4218.831246750157;4224.408582798411;4224.767637779921;3598.946015809765;3622.3660859349507;3716.2567486502808;3719.293334266508;3751.924961500782;5063.367079115111;5089.312942752755;5092.159793634083;5101.489851014869;5107.7446127693465;4775.307580400857;4780.569748722597;4812.711237325771;4843.273508973647;4869.220924652039;5328.706921119337;5417.1852429436185;5435.1847222916485;5458.918116228259;5473.452654734535;4136.131412403399;4145.647619952308;4150.418941348214;4154.626083652486;4167.1457351242925;5716;5758.769649214027;5767.365589785162;5770.596058275923;5772.220750198711;4144.544100148981;4211.873643790691;4239.342901850218;4250.44858626599;4256.510501292391;4296.871093867189;4312.849050283225;4313.352997050468;4343;4344.674149438804;4617.884552886205;4664.183767840615;4723.551262630044;4804.375431193923;4828.561576403964;5421.213923981;5435.320584926884;5437.374701909331;5460.645058071213;5467;1431.6921861799763;1441.7693169092895;1449.2029383838847;1449.8256412306066;1463.7584798508126;917.958691858868;954.8185844689486;962.4465932089076;963.9204091417517;966.7341481092756;5095.0574143783515;5105.183170692671;5109.540141387293;5132.28148059272;5140.298984730987;5447.046766815792;5461.542305962333;5489;5490.890182196334;5527.517663871735;5024.371953505812;5132.666376685504;5214.60890433219;5251.142693008951;5280.498352656491;2872.0809341010677;2886.3794284228993;2892.1901867476718;2893.7284231877875;2900.8404537750625;5661.830145095571;5695.971520142372;5704.229928959538;5718.79984200551;5771.769129234784;5773.191753154561;5777.19119323295;5801.680907550125;5812.389699081536;5815.73829177688;5899.439553242435;5923;5929.288485381781;5950.583459157818;5982.102684597258;5471.23402723627;5613.550915926634;5647.209390685225;5660.660360378391;5709.486146246858;5589.664620122806;5605.467480589337;5623.465770751772;5658.886822263614;5661.858453538694;5673.489385955284;5920.526357891445;5947.672877991579;5954.612950158225;5961.52307815365;4066;4089.2230476209425;4106.445629839934;4128.855490057834;4129.545749967561;5493.807716729895;5530.668159910419;5625.184348269559;5687.687177205294;5707.514861236841;5479.972600137134;5483.259759932358;5486.533644640251;5506.889862202814;5517.393086760373;5448.591355648421;5455.854270603218;5471.671699698031;5480.150576660624;5489.890202196014;5233.241180028951;5407.567394608501;5459.7270136492225;5490.298007617651;5505.256790333414;5464.235007099089;5495.505404513613;5520.53075488588;5534.335879694462;5564.4713752193475;5236.319278493771;5365.543928765943;5380.246765452762;5395.325584301962;5442.292501974718 11:52:52 INFO - PROCESS | 11262 | |5;yui.html;719.8452332748458;744.8175197076717;766.4060353226249;775.5618075787177;860.681547827304;15918.840811591881;16716.331346746116;16785.66428671426;16849.747253791204;17028.829711702896;12150.270983740982;15165.165915874622;15199.77200341993;15378.84621153788;15404.075755454653;823.3454403749018;846.0439703135448;848.0713618587637;848.9981821450685;849.0617867256685;835.4611275727152;839.3872473094644;840.0549381945311;843.641452382738;843.7215718812807;866.0646501778097;874.807542340684;881.3566096749377;881.8104107616861;883.4699180491718;877.609463788608;878.2622597018471;879.151618687966;879.5118709116438;880.7842078690697;629.7386584567445;634.6065439427538;634.6287421858218;635.9300476947532;646.6281887914421;15682.294296756674;15682.68634627301;15714.68570628581;15719.214039298104;15770.842291577166;14121.929390353085;15059.924700376429;15439.382424702999;15516.301766420538;15649.452269170639;12187.32969686667;12376.195547289397;12400.503979840796;12533.623991280276;12560.81158782619;3725.832337544817;3832.5209348831395;3856.633619806114;3857.8263978121054;3993.7603743775176;68705.65647171732;69483;69793.30206697919;79616.60191699062;84298.57850710768;11631.418429078512;11671.416429178507;11771.352575608424;11861.11041671878;12436.875631243753;21355.67966480504;21365.67951480729;21513.67729484059;21572.784272157078;21711.457213569785;7249.528780629348;7457.403407727369;7483.214262502359;8447.831043379098;8452.197041281068;4422.09347083847;4561.110583436198;4577.130345234461;4609.285560738091;4649.767511624405;3516.2791627716256;3526.613143027029;3572.8749493767596;3611.6930060944587;3687.1335236219466;677.6108976597955;683.5386114372878;689.3106893106893;699.464909344352;701.9227884932653;725.354434553248;727.058459295214;749;762.9771106866802;769.3960241210734;9649.614015439443;10103.545340459697;10220.744481388025;10656.413897235572;11048.834267485994;541.6777017674477;712.4407340237889;712.4478529139958;768.0322793280395;781.4100354232518;4481.215787237221;5137.640365174477;5142.434332223453;5149.742512874416;5149.76826042829;83342.74985875217;83640.58179709184;86415.56792215999;87523;87905.1209487897;42408.36387454191;46600.7669961648;54665.453345466834;60481.092783608285;75469;61020.032788196215;61516.38483615196;61994;62841;63887.68056159689;9888.406695598287;10035.29752917318;10291.22815788804;10331.32846364984;10602.469876506299;37988.43017354687;42535.760857663474;42540.36189457099;44567;44912;54013.189802153785;58609.12086318623;58779.4122058791;59104.408955909894;61267.38732612617;11667.883321166679;12539.24764514132;12678.842618495664;13389.330533473481;13478.258695771827;14829.851701482847;14883.851161488246;15131.319090640727;15176.468823591122;15437.382504699686;12960;13640.590782276548;13792.586222413343;14252.216128113054;14367;12613;12658.43037063316;12769.361531923181;12889.935550322189;13794.448222071005;13233;13781.724365512835;13977.650558735706;14217;14274.14355138695;11172;11249.268797528135;11632.88367116318;11714.414279286171;12196.268223906594;10446.843297350393;10452.947735261276;11283.004537186669;11629;11687.84571684849 11:52:52 INFO - PROCESS | 11262 | __end_tp_report 11:52:52 INFO - PROCESS | 11262 | __start_cc_report 11:52:52 INFO - PROCESS | 11262 | _x_x_mozilla_cycle_collect,1485 11:52:52 INFO - PROCESS | 11262 | __end_cc_report 11:52:52 INFO - PROCESS | 11262 | __startTimestamp1482436372587__endTimestamp 11:52:52 INFO - PROCESS | 11262 | 11:52:52 INFO - PROCESS | 11262 | ------- Summary: start ------- 11:52:52 INFO - PROCESS | 11262 | Number of tests: 6 11:52:52 INFO - PROCESS | 11262 | 11:52:52 INFO - PROCESS | 11262 | [#0] dojo.html Cycles:165 Average:5289.71 Median:5502.28 stddev:617.21 (11.2%) stddev-sans-first:593.45 11:52:52 INFO - PROCESS | 11262 | Values: 3045.2 3074.0 3090.8 3124.0 3138.7 5196.8 5205.1 5254.4 5324.4 5374.7 5253.1 5312.4 5324.6 5332.9 5379.3 4803.0 4849.8 4877.3 4878.4 4935.6 4886.6 4929.8 4958.2 4960.6 5007.5 4885.6 4925.3 4936.2 4940.5 4955.8 4685.8 4708.0 4715.0 4780.0 4780.3 4792.0 4832.7 4833.5 4835.3 4860.1 5316.4 5318.1 5324.8 5327.3 5328.2 5695.7 5695.9 5701.2 5711.7 5756.4 5555.9 5569.6 5601.7 5604.8 5696.6 5315.2 5319.0 5344.8 5358.9 5362.8 5763.2 5768.3 5820.3 5830.9 5831.4 5473.6 5502.3 5589.8 5603.8 5605.1 5675.0 5704.0 5705.7 5713.1 5811.6 5621.3 5644.3 5671.4 5671.4 5716.9 5598.5 5681.1 5696.9 5705.7 5756.7 4176.0 4276.2 4278.1 4291.6 4335.2 3774.2 3784.7 3804.2 3817.1 3859.2 5386.6 5416.7 5420.6 5420.6 5432.4 5766.9 5772.3 5788.2 5788.6 5813.2 5212.5 5253.9 5313.1 5364.5 5376.8 4761.5 4766.4 4772.3 4805.9 4806.9 5961.6 5969.0 5972.0 5977.9 5986.8 5645.7 5689.6 5707.1 5735.2 5743.9 6000.1 6017.4 6030.2 6064.6 6090.2 5633.4 5645.9 5674.9 5684.3 5687.8 5581.6 5606.3 5627.0 5773.8 5787.8 5578.0 5580.4 5581.6 5585.9 5588.8 5525.2 5542.7 5581.9 5590.6 5597.7 5469.5 5498.0 5514.3 5529.1 5591.2 5572.8 5578.7 5586.4 5588.9 5606.4 5442.4 5456.6 5457.7 5465.1 5512.1 11:52:52 INFO - PROCESS | 11262 | 11:52:52 INFO - PROCESS | 11262 | [#1] ext.html Cycles:180 Average:62584.04 Median:200877.22 stddev:127777.14 (63.6%) stddev-sans-first:128050.66 11:52:52 INFO - PROCESS | 11262 | Values: 534.4 579.4 592.4 597.8 604.9 33073.8 43406.0 44382.0 44455.1 44467.1 45630.3 46081.0 46108.0 46131.3 46154.5 8215.1 8848.6 9028.2 9031.6 9033.9 8266.4 10417.5 10635.3 10684.4 11041.9 10747.0 10818.2 10818.4 10818.5 10825.7 10766.1 10819.7 10830.4 10840.9 10843.8 10559.3 10625.1 10627.1 10632.4 10634.9 43076.4 43380.6 43460.0 43467.8 43473.3 3277.7 3382.9 3439.7 3583.2 3643.0 27030.3 29431.1 29601.6 29639.3 29673.4 4085.6 4192.4 4213.8 4267.5 4409.3 362830.0 362930.2 363667.0 364383.2 364969.0 52324.5 52423.7 52755.5 52850.7 52869.5 55569.3 56154.7 56179.7 56214.7 56303.4 15276.5 15801.0 15812.2 15829.7 15844.8 11295.0 11344.3 12113.6 12201.9 12298.2 16489.5 17229.7 17320.3 17366.5 17385.2 6602.9 6617.0 6648.1 6701.3 6914.2 955.7 1078.6 1112.0 1144.7 1156.4 31845.4 32239.8 32353.7 32672.7 33339.3 1094.9 1102.0 1116.7 1125.1 1132.1 15933.4 16961.7 16962.8 16969.1 17280.2 583699.0 585008.0 587834.0 591400.0 593177.0 58966.7 59645.0 59699.4 59855.4 59870.0 1371.6 1397.7 1403.2 1408.6 1424.2 30637.8 31153.4 31457.5 31745.5 32270.4 52219.7 52496.0 52522.0 52605.0 52680.2 461191.0 462285.0 463357.0 464456.0 465241.0 28396.3 28775.1 28827.3 28833.9 28870.1 40827.8 45575.8 45975.8 50199.7 51220.2 39529.6 40311.9 40510.6 41037.0 42179.4 39516.8 39754.4 40012.2 40980.0 41253.0 39993.6 40381.0 40759.6 40865.0 41439.6 33854.8 36144.6 36785.4 36788.0 36844.8 27462.6 27786.0 27901.7 27995.0 28030.0 11:52:52 INFO - PROCESS | 11262 | 11:52:52 INFO - PROCESS | 11262 | [#2] jquery.html Cycles:180 Average:25003.14 Median:402577.00 stddev:65987.69 (16.4%) stddev-sans-first:66146.93 11:52:52 INFO - PROCESS | 11262 | Values: 390.4 396.7 407.3 409.3 428.0 13457.2 15424.3 18060.2 18298.6 18744.9 18374.3 18625.4 18661.7 18802.5 18802.9 5516.2 5522.3 5732.7 5733.3 5733.4 5568.2 5646.1 5693.2 5708.1 5717.1 5390.5 5673.2 5679.1 5681.1 5682.2 5588.7 5734.2 5741.7 5742.8 5752.3 5520.4 5571.8 5593.9 5752.4 5788.8 13547.8 13630.4 13637.5 13811.6 13830.4 2088.3 2150.8 2210.8 2382.4 2620.5 9131.4 9872.9 9919.3 9932.4 10463.8 1949.8 1950.2 2000.1 2024.8 2046.0 71903.0 73702.3 74022.3 74428.6 76570.6 10748.7 10759.8 10963.6 11101.4 11107.8 15083.5 15089.5 15091.3 15122.7 15135.8 7685.6 8127.2 8128.2 8368.2 8375.9 7763.7 7764.0 7775.3 7907.4 8012.4 4610.1 4663.5 4697.5 4760.9 4809.0 1928.9 1933.9 1998.9 2007.5 2053.4 922.7 931.8 993.4 1021.2 1075.8 17358.5 18427.3 18706.7 18777.7 18949.6 927.8 935.4 963.5 984.7 993.8 7751.9 10092.5 10537.3 10539.0 10605.8 394486.0 396783.0 401459.0 403695.0 404195.0 53216.0 55492.8 79961.6 83281.0 85974.1 941.6 953.7 991.6 991.7 992.4 16484.3 16659.6 16827.6 16971.1 17116.7 37946.4 39260.0 39305.4 39585.2 39978.4 52189.7 52338.5 52572.2 53792.5 54229.0 7412.8 7737.0 8201.4 8364.3 8540.8 12298.0 12760.0 12908.9 13138.7 13211.7 10956.0 11188.4 11344.3 11499.2 11640.0 10889.2 10991.9 11085.4 11196.8 11708.4 11211.6 11382.5 11420.3 11516.1 11652.8 7402.7 7679.2 7767.8 7874.3 8069.1 8968.0 10530.2 11124.0 11162.8 11411.2 11:52:52 INFO - PROCESS | 11262 | 11:52:52 INFO - PROCESS | 11262 | [#3] mootools.html Cycles:180 Average:5347.44 Median:5047.92 stddev:2948.02 (58.4%) stddev-sans-first:2941.58 11:52:52 INFO - PROCESS | 11262 | Values: 1428.5 1438.9 1590.6 1685.8 1752.4 7745.0 8105.2 8110.9 8137.5 8151.3 7302.6 7502.0 7752.1 8003.2 8058.1 2218.7 2247.5 2248.4 2254.4 2257.2 2269.1 2299.4 2332.9 2334.1 2341.9 2275.3 2278.2 2278.4 2299.0 2305.5 2239.5 2255.7 2273.0 2273.2 2277.6 2233.8 2254.4 2260.1 2260.4 2261.5 8083.2 8091.4 8190.1 8195.3 8200.5 4854.3 4952.4 4989.2 4989.8 4992.5 2980.7 3055.5 3279.9 3285.2 3300.2 960.7 966.9 975.6 984.5 1010.7 10983.5 10985.9 10989.7 10992.6 11019.4 4167.4 4399.2 4447.1 4449.4 4476.6 9489.2 9490.4 9491.9 9492.0 9493.5 5034.6 5040.9 5043.7 5045.0 5050.9 4466.5 4525.8 4630.4 4631.9 4646.2 3817.8 3869.9 3882.2 3962.3 4092.9 1265.8 1291.1 1297.8 1305.5 1311.9 790.6 846.8 877.9 906.1 916.1 5426.8 5443.2 5532.1 5617.0 5707.1 891.5 955.6 958.2 982.3 1062.3 3565.4 3777.3 3796.5 3799.1 3937.1 9733.9 10035.5 10039.1 10043.4 10050.3 9628.4 9762.6 9865.6 9966.8 10001.1 7598.2 7679.5 7695.0 7704.4 7728.2 5452.0 5460.5 5515.4 5534.2 5584.7 8969.6 8981.6 9037.0 9046.8 9140.1 8842.8 9051.0 9099.3 9341.3 9438.6 6994.1 7139.3 7142.7 7142.9 7143.1 7921.0 7951.3 8000.5 8005.3 8007.6 7068.6 7100.5 7214.8 7223.4 7370.9 7032.1 7113.6 7128.8 7139.1 7150.4 5915.6 6004.4 6036.9 6081.1 6166.1 4290.5 4363.3 4429.8 4464.1 4639.2 4485.3 4503.4 4577.2 4621.2 4642.2 11:52:52 INFO - PROCESS | 11262 | 11:52:52 INFO - PROCESS | 11262 | [#4] prototype.html Cycles:180 Average:4664.27 Median:5246.17 stddev:1339.23 (25.5%) stddev-sans-first:1303.20 11:52:52 INFO - PROCESS | 11262 | Values: 347.5 385.7 387.9 388.8 399.8 5078.5 5208.4 5231.4 5241.2 5325.3 5215.0 5240.4 5265.4 5319.7 5327.3 4220.4 4222.4 4234.3 4236.4 4261.0 4031.3 4067.4 4131.8 4170.2 4230.8 4191.0 4192.4 4199.8 4202.5 4222.7 4202.7 4206.2 4218.8 4224.4 4224.8 3598.9 3622.4 3716.3 3719.3 3751.9 5063.4 5089.3 5092.2 5101.5 5107.7 4775.3 4780.6 4812.7 4843.3 4869.2 5328.7 5417.2 5435.2 5458.9 5473.5 4136.1 4145.6 4150.4 4154.6 4167.1 5716.0 5758.8 5767.4 5770.6 5772.2 4144.5 4211.9 4239.3 4250.4 4256.5 4296.9 4312.8 4313.4 4343.0 4344.7 4617.9 4664.2 4723.6 4804.4 4828.6 5421.2 5435.3 5437.4 5460.6 5467.0 1431.7 1441.8 1449.2 1449.8 1463.8 918.0 954.8 962.4 963.9 966.7 5095.1 5105.2 5109.5 5132.3 5140.3 5447.0 5461.5 5489.0 5490.9 5527.5 5024.4 5132.7 5214.6 5251.1 5280.5 2872.1 2886.4 2892.2 2893.7 2900.8 5661.8 5696.0 5704.2 5718.8 5771.8 5773.2 5777.2 5801.7 5812.4 5815.7 5899.4 5923.0 5929.3 5950.6 5982.1 5471.2 5613.6 5647.2 5660.7 5709.5 5589.7 5605.5 5623.5 5658.9 5661.9 5673.5 5920.5 5947.7 5954.6 5961.5 4066.0 4089.2 4106.4 4128.9 4129.5 5493.8 5530.7 5625.2 5687.7 5707.5 5480.0 5483.3 5486.5 5506.9 5517.4 5448.6 5455.9 5471.7 5480.2 5489.9 5233.2 5407.6 5459.7 5490.3 5505.3 5464.2 5495.5 5520.5 5534.3 5564.5 5236.3 5365.5 5380.2 5395.3 5442.3 11:52:52 INFO - PROCESS | 11262 | 11:52:52 INFO - PROCESS | 11262 | [#5] yui.html Cycles:180 Average:17520.32 Median:42538.06 stddev:22125.95 (52.0%) stddev-sans-first:22152.05 11:52:52 INFO - PROCESS | 11262 | Values: 719.8 744.8 766.4 775.6 860.7 15918.8 16716.3 16785.7 16849.7 17028.8 12150.3 15165.2 15199.8 15378.8 15404.1 823.3 846.0 848.1 849.0 849.1 835.5 839.4 840.1 843.6 843.7 866.1 874.8 881.4 881.8 883.5 877.6 878.3 879.2 879.5 880.8 629.7 634.6 634.6 635.9 646.6 15682.3 15682.7 15714.7 15719.2 15770.8 14121.9 15059.9 15439.4 15516.3 15649.5 12187.3 12376.2 12400.5 12533.6 12560.8 3725.8 3832.5 3856.6 3857.8 3993.8 68705.7 69483.0 69793.3 79616.6 84298.6 11631.4 11671.4 11771.4 11861.1 12436.9 21355.7 21365.7 21513.7 21572.8 21711.5 7249.5 7457.4 7483.2 8447.8 8452.2 4422.1 4561.1 4577.1 4609.3 4649.8 3516.3 3526.6 3572.9 3611.7 3687.1 677.6 683.5 689.3 699.5 701.9 725.4 727.1 749.0 763.0 769.4 9649.6 10103.5 10220.7 10656.4 11048.8 541.7 712.4 712.4 768.0 781.4 4481.2 5137.6 5142.4 5149.7 5149.8 83342.7 83640.6 86415.6 87523.0 87905.1 42408.4 46600.8 54665.5 60481.1 75469.0 61020.0 61516.4 61994.0 62841.0 63887.7 9888.4 10035.3 10291.2 10331.3 10602.5 37988.4 42535.8 42540.4 44567.0 44912.0 54013.2 58609.1 58779.4 59104.4 61267.4 11667.9 12539.2 12678.8 13389.3 13478.3 14829.9 14883.9 15131.3 15176.5 15437.4 12960.0 13640.6 13792.6 14252.2 14367.0 12613.0 12658.4 12769.4 12889.9 13794.4 13233.0 13781.7 13977.7 14217.0 14274.1 11172.0 11249.3 11632.9 11714.4 12196.3 10446.8 10452.9 11283.0 11629.0 11687.8 11:52:52 INFO - PROCESS | 11262 | -------- Summary: end -------- 11:52:52 INFO - PROCESS | 11262 | 11:52:53 INFO - TEST-INFO | 11262: exit 0 11:52:53 INFO - TEST-OK | dromaeo_css | took 1115697ms 11:52:53 INFO - TEST-START | kraken 11:52:53 INFO - operating with platform_type : linux_ 11:52:53 INFO - Initialising browser for kraken test... 11:52:53 INFO - TEST-INFO | started process 11564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptasPKW/profile http://localhost:56750/getInfo.html) 11:52:53 INFO - PROCESS | 11564 | 1482436373802 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 11:52:56 INFO - PROCESS | 11564 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 11:52:56 INFO - PROCESS | 11564 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 11:52:56 INFO - PROCESS | 11564 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 11:52:57 INFO - PROCESS | 11564 | __metrics Screen width/height:1600/1200 11:52:57 INFO - PROCESS | 11564 | colorDepth:24 11:52:57 INFO - PROCESS | 11564 | Browser inner width/height: 1024/697 11:52:57 INFO - PROCESS | 11564 | __metrics 11:52:57 INFO - PROCESS | 11564 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:52:57 INFO - PROCESS | 11564 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:52:58 INFO - PROCESS | 11564 | console.error: PushService: 11:52:58 INFO - PROCESS | 11564 | stateChangeProcessEnqueue: Error transitioning state 11:52:58 INFO - PROCESS | 11564 | UnknownError 11:52:58 INFO - TEST-INFO | 11564: exit 0 11:52:58 INFO - Browser initialized. 11:52:58 INFO - Running cycle 1/1 for kraken test... 11:52:58 INFO - TEST-INFO | started process 11648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptasPKW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:53:10 INFO - PROCESS | 11648 | RSS: Main: 147009536 11:53:10 INFO - PROCESS | 11648 | 11:53:13 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56750/tests/kraken/driver.html?testName=audio-beat-detection) 11:53:14 INFO - PROCESS | 11648 | RSS: Main: 201633792 11:53:14 INFO - PROCESS | 11648 | 11:53:16 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56750/tests/kraken/driver.html?testName=audio-dft) 11:53:17 INFO - PROCESS | 11648 | RSS: Main: 179982336 11:53:17 INFO - PROCESS | 11648 | 11:53:20 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56750/tests/kraken/driver.html?testName=audio-fft) 11:53:20 INFO - PROCESS | 11648 | RSS: Main: 262037504 11:53:20 INFO - PROCESS | 11648 | 11:53:23 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56750/tests/kraken/driver.html?testName=audio-oscillator) 11:53:23 INFO - PROCESS | 11648 | RSS: Main: 172724224 11:53:23 INFO - PROCESS | 11648 | 11:53:25 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56750/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:53:26 INFO - PROCESS | 11648 | RSS: Main: 178143232 11:53:26 INFO - PROCESS | 11648 | 11:53:29 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56750/tests/kraken/driver.html?testName=imaging-darkroom) 11:53:29 INFO - PROCESS | 11648 | RSS: Main: 216764416 11:53:29 INFO - PROCESS | 11648 | 11:53:33 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56750/tests/kraken/driver.html?testName=imaging-desaturate) 11:53:33 INFO - PROCESS | 11648 | RSS: Main: 216805376 11:53:33 INFO - PROCESS | 11648 | 11:53:36 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56750/tests/kraken/driver.html?testName=json-parse-financial) 11:53:37 INFO - PROCESS | 11648 | RSS: Main: 215629824 11:53:37 INFO - PROCESS | 11648 | 11:53:38 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56750/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:53:39 INFO - PROCESS | 11648 | RSS: Main: 177766400 11:53:39 INFO - PROCESS | 11648 | 11:53:41 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56750/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:53:41 INFO - PROCESS | 11648 | RSS: Main: 185556992 11:53:41 INFO - PROCESS | 11648 | 11:53:43 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56750/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:53:44 INFO - PROCESS | 11648 | RSS: Main: 193941504 11:53:44 INFO - PROCESS | 11648 | 11:53:46 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:53:47 INFO - PROCESS | 11648 | RSS: Main: 202870784 11:53:47 INFO - PROCESS | 11648 | 11:53:50 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:53:51 INFO - PROCESS | 11648 | RSS: Main: 199237632 11:53:51 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | Cycle 1(1): loaded http://localhost:56750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56750/tests/kraken/driver.html?testName=ai-astar) 11:53:52 INFO - PROCESS | 11648 | RSS: Main: 251334656 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | __start_tp_report 11:53:52 INFO - PROCESS | 11648 | _x_x_mozilla_page_load 11:53:52 INFO - PROCESS | 11648 | _x_x_mozilla_page_load_details 11:53:52 INFO - PROCESS | 11648 | |i|pagename|runs| 11:53:52 INFO - PROCESS | 11648 | |0;ai-astar;110;112;112;111;111;113;113;111;111;112 11:53:52 INFO - PROCESS | 11648 | |1;audio-beat-detection;156;121;120;161;144;121;123;120;141;122 11:53:52 INFO - PROCESS | 11648 | |2;audio-dft;162;161;162;161;158;161;161;161;162;161 11:53:52 INFO - PROCESS | 11648 | |3;audio-fft;75;76;75;115;77;76;76;75;89;75 11:53:52 INFO - PROCESS | 11648 | |4;audio-oscillator;83;83;114;84;83;84;96;83;83;102 11:53:52 INFO - PROCESS | 11648 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 11:53:52 INFO - PROCESS | 11648 | |6;imaging-darkroom;147;146;146;148;148;147;147;147;146;146 11:53:52 INFO - PROCESS | 11648 | |7;imaging-desaturate;96;97;95;95;96;97;95;95;96;95 11:53:52 INFO - PROCESS | 11648 | |8;json-parse-financial;50;49;49;50;50;52;51;51;50;50 11:53:52 INFO - PROCESS | 11648 | |9;json-stringify-tinderbox;64;65;64;64;64;65;65;66;65;65 11:53:52 INFO - PROCESS | 11648 | |10;stanford-crypto-aes;80;80;79;85;80;85;87;80;85;81 11:53:52 INFO - PROCESS | 11648 | |11;stanford-crypto-ccm;135;126;129;128;126;130;132;126;158;135 11:53:52 INFO - PROCESS | 11648 | |12;stanford-crypto-pbkdf2;167;165;163;167;164;167;168;166;164;167 11:53:52 INFO - PROCESS | 11648 | |13;stanford-crypto-sha256-iterative;72;62;65;61;64;64;63;61;72;59 11:53:52 INFO - PROCESS | 11648 | __end_tp_report 11:53:52 INFO - PROCESS | 11648 | __start_cc_report 11:53:52 INFO - PROCESS | 11648 | _x_x_mozilla_cycle_collect,1604 11:53:52 INFO - PROCESS | 11648 | __end_cc_report 11:53:52 INFO - PROCESS | 11648 | __startTimestamp1482436432953__endTimestamp 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | ------- Summary: start ------- 11:53:52 INFO - PROCESS | 11648 | Number of tests: 14 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:0.97 (0.9%) stddev-sans-first:0.83 11:53:52 INFO - PROCESS | 11648 | Values: 110.0 112.0 112.0 111.0 111.0 113.0 113.0 111.0 111.0 112.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:132.00 stddev:16.14 (12.2%) stddev-sans-first:14.80 11:53:52 INFO - PROCESS | 11648 | Values: 156.0 121.0 120.0 161.0 144.0 121.0 123.0 120.0 141.0 122.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 11:53:52 INFO - PROCESS | 11648 | Values: 162.0 161.0 162.0 161.0 158.0 161.0 161.0 161.0 162.0 161.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:12.71 (16.7%) stddev-sans-first:13.31 11:53:52 INFO - PROCESS | 11648 | Values: 75.0 76.0 75.0 115.0 77.0 76.0 76.0 75.0 89.0 75.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:83.00 stddev:10.91 (13.1%) stddev-sans-first:11.31 11:53:52 INFO - PROCESS | 11648 | Values: 83.0 83.0 114.0 84.0 83.0 84.0 96.0 83.0 83.0 102.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:53:52 INFO - PROCESS | 11648 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 11:53:52 INFO - PROCESS | 11648 | Values: 147.0 146.0 146.0 148.0 148.0 147.0 147.0 147.0 146.0 146.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 11:53:52 INFO - PROCESS | 11648 | Values: 96.0 97.0 95.0 95.0 96.0 97.0 95.0 95.0 96.0 95.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:0.92 (1.8%) stddev-sans-first:0.97 11:53:52 INFO - PROCESS | 11648 | Values: 50.0 49.0 49.0 50.0 50.0 52.0 51.0 51.0 50.0 50.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 11:53:52 INFO - PROCESS | 11648 | Values: 64.0 65.0 64.0 64.0 64.0 65.0 65.0 66.0 65.0 65.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:83.00 stddev:2.94 (3.5%) stddev-sans-first:3.00 11:53:52 INFO - PROCESS | 11648 | Values: 80.0 80.0 79.0 85.0 80.0 85.0 87.0 80.0 85.0 81.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:131.00 stddev:9.59 (7.3%) stddev-sans-first:10.13 11:53:52 INFO - PROCESS | 11648 | Values: 135.0 126.0 129.0 128.0 126.0 130.0 132.0 126.0 158.0 135.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:167.00 stddev:1.69 (1.0%) stddev-sans-first:1.73 11:53:52 INFO - PROCESS | 11648 | Values: 167.0 165.0 163.0 167.0 164.0 167.0 168.0 166.0 164.0 167.0 11:53:52 INFO - PROCESS | 11648 | 11:53:52 INFO - PROCESS | 11648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:4.42 (6.9%) stddev-sans-first:3.71 11:53:52 INFO - PROCESS | 11648 | Values: 72.0 62.0 65.0 61.0 64.0 64.0 63.0 61.0 72.0 59.0 11:53:52 INFO - PROCESS | 11648 | -------- Summary: end -------- 11:53:52 INFO - PROCESS | 11648 | 11:53:53 INFO - TEST-INFO | 11648: exit 0 11:53:54 INFO - TEST-OK | kraken | took 60657ms 11:53:54 INFO - SUITE-END | took 1176s 11:53:54 INFO - Completed test suite (00:19:36) 11:53:54 INFO - javascript benchmark 11:53:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.19302384868, 3074.0, 3090.8145511269317, 3124.047165614487, 3138.6547479777237, 5196.844094677156, 5205.115130427826, 5254.395744489375, 5324.387695415028, 5374.731263436827, 5253.0544501989725, 5312.442193569677, 5324.600654950875, 5332.866678333044, 5379.273798037264, 4803.0, 4849.757512124397, 4877.317175595419, 4878.365812444377, 4935.555799978001, 4886.560209581137, 4929.827456039039, 4958.206686930092, 4960.578350840183, 5007.524285192901, 4885.584725298354, 4925.33507976424, 4936.185529387647, 4940.456549779521, 4955.752212389384, 4685.765711714401, 4707.976460117712, 4715.033418149305, 4780.020095880336, 4780.282957556359, 4792.0, 4832.685875418087, 4833.468318484964, 4835.323054772335, 4860.125177468054, 5316.38861530925, 5318.149096144637, 5324.760385782649, 5327.334083239595, 5328.20076988451, 5695.686737229451, 5695.943040569583, 5701.2018317435595, 5711.685857277848, 5756.424357564252, 5555.861103472405, 5569.582281328917, 5601.663900165962, 5604.8038318658655, 5696.572757043197, 5315.229291752674, 5318.97340513295, 5344.7862085516535, 5358.892822143535, 5362.839114826562, 5763.221965034667, 5768.278965129359, 5820.30156381237, 5830.883382332329, 5831.3877042910735, 5473.616846820764, 5502.284702988586, 5589.80435684749, 5603.775848966077, 5605.075162598126, 5674.971625141848, 5704.0, 5705.657660540381, 5713.114467257582, 5811.622244554175, 5621.297337832771, 5644.294463192101, 5671.404502527175, 5671.404502527258, 5716.942830571724, 5598.524125449301, 5681.062624666966, 5696.857578560569, 5705.74324155414, 5756.7121643917635, 4176.0395109125075, 4276.230278549829, 4278.144371125787, 4291.592298731678, 4335.154644844225, 3774.245150969817, 3784.735068545175, 3804.2011177653003, 3817.10298079951, 3859.2474467479133, 5386.569074474032, 5416.674999500043, 5420.593455490775, 5420.593455490854, 5432.375276843135, 5766.942330576724, 5772.278465191851, 5788.160716696139, 5788.594798364158, 5813.215215945793, 5212.478752124757, 5253.894922101613, 5313.123334649817, 5364.490373414519, 5376.758045887945, 4761.4524329701835, 4766.404199475066, 4772.331873537708, 4805.8558243252755, 4806.879828004258, 5961.552883533665, 5968.9701551492835, 5972.044472884318, 5977.9402205977385, 5986.760529578768, 5645.71771411436, 5689.573282003784, 5707.1153971134545, 5735.168400581976, 5743.856403589776, 6000.069989151689, 6017.368176341596, 6030.246219222598, 6064.605800622945, 6090.208272924491, 5633.352164501135, 5645.943540564706, 5674.858128546819, 5684.261046063985, 5687.77248910039, 5581.553475721851, 5606.299212598426, 5627.043402621646, 5773.797917072882, 5787.768489260382, 5577.972110139585, 5580.35825880029, 5581.581381396492, 5585.916211256916, 5588.77644894216, 5525.171224316385, 5542.695151766691, 5581.944180558143, 5590.5527557796095, 5597.720113994203, 5469.453054694499, 5498.0, 5514.310711161105, 5529.115341545334, 5591.245181900554, 5572.777088916398, 5578.748956297058, 5586.413426590312, 5588.916166257591, 5606.411326810789, 5442.428545002717, 5456.645318054314, 5457.672539647634, 5465.125579907196, 5512.090505066619], "value": 5247.00923411384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.4161253465284, 579.368488347701, 592.4194289596198, 597.7519329478266, 604.9001914684077, 33073.834630826845, 43406.0, 44382.0, 44455.10945803406, 44467.11065778683, 45630.31554526685, 46081.0, 46108.0, 46131.30803037957, 46154.538454615446, 8215.137410571893, 8848.5575721214, 9028.187463128317, 9031.638734450615, 9033.864492032624, 8266.421350505467, 10417.53121109548, 10635.308704934194, 10684.412357320345, 11041.944790276037, 10747.032767050963, 10818.188635852302, 10818.350898946088, 10818.513166907507, 10825.67522974312, 10766.138708903309, 10819.67540973772, 10830.350178989207, 10840.891591084146, 10843.783124337508, 10559.26085174038, 10625.149988000941, 10627.14982801374, 10632.415217163052, 10634.893651063468, 43076.35385469221, 43380.56619433797, 43460.0, 43467.782661086494, 43473.347899781525, 3277.672232776727, 3382.932341353184, 3439.724822014233, 3583.229605634775, 3643.034595832107, 27030.32424189391, 29431.11706648804, 29601.555976660366, 29639.25901852471, 29673.40653186924, 4085.632293093636, 4192.434021407102, 4213.810378532943, 4267.509236437819, 4409.294512877957, 362830.0, 362930.22418654966, 363666.9999999974, 364383.17808411055, 364969.0, 52324.476755232725, 52423.73788131035, 52755.47244527505, 52850.73574632179, 52869.47130528645, 55569.33168019864, 56154.719226403606, 56179.71910140423, 56214.71892640593, 56303.43696563064, 15276.541703748906, 15801.0, 15812.209389530477, 15829.683406332038, 15844.76232856508, 11295.0, 11344.262622929484, 12113.576024839089, 12201.938990305169, 12298.20061695987, 16489.505314840575, 17229.7415538767, 17320.307187712602, 17366.47900562985, 17385.217665205095, 6602.86794264112, 6616.966915165393, 6648.135742353463, 6701.29636388182, 6914.239433662293, 955.6846240740539, 1078.5955266774959, 1111.9888801112047, 1144.6566030190909, 1156.392893730798, 31845.363092738015, 32239.838800805846, 32353.676463235537, 32672.673273266962, 33339.333213335594, 1094.8576685030896, 1101.9944900275448, 1116.6761639124725, 1125.139268459629, 1132.1282612388416, 15933.36266549325, 16961.745573816403, 16962.830371696124, 16969.0667013313, 17280.22238999248, 583699.0, 585008.0, 587834.0, 591400.0, 593177.0, 58966.70516647389, 59645.0, 59699.40300596938, 59855.40144598585, 59870.0, 1371.5748118083427, 1397.6925076483158, 1403.2422491854284, 1408.6196726883684, 1424.181095869879, 30637.846810765805, 31153.376932461677, 31457.52813707842, 31745.523817143225, 32270.35459290848, 52219.73890130525, 52496.0, 52522.0, 52605.0, 52680.20979685231, 461191.0, 462285.0, 463357.0, 464456.0, 465241.0, 28396.290092747848, 28775.136745897657, 28827.279318017216, 28833.855830720713, 28870.133895983156, 40827.7958610205, 45575.77212113918, 45975.77012114918, 50199.74900125622, 51220.231696523835, 39529.604703952595, 40311.89511703513, 40510.59489405068, 41037.0, 42179.367309491, 39516.80241598774, 39754.40368394534, 40012.199756004135, 40980.0, 41253.0, 39993.60006399899, 40381.0, 40759.59240407558, 40865.0, 41439.58560414357, 33854.830725846216, 36144.638553614124, 36785.448218277284, 36788.0, 36844.81577592095, 27462.5880611787, 27786.0, 27901.720982789913, 27995.0, 28030.0], "value": 20314.98818868646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.377348129733, 396.74608250719547, 407.3360422511306, 409.25719818529365, 428.0, 13457.192568445887, 15424.305906234218, 18060.187291571878, 18298.634027319447, 18744.90627546864, 18374.265029398808, 18625.441236762887, 18661.720074198896, 18802.529936751587, 18802.905985470054, 5516.200150978116, 5522.254495643077, 5732.742026608792, 5733.283339582552, 5733.426657334254, 5568.2181701855425, 5646.124850648135, 5693.231413759152, 5708.1437784332265, 5717.113847353646, 5390.5418039466695, 5673.177389278552, 5679.091345384739, 5681.147827825838, 5682.232898558704, 5588.720563971785, 5734.197212390269, 5741.712914354286, 5742.827715168552, 5752.338481074647, 5520.392756796749, 5571.832845014656, 5593.888122237573, 5752.395998420189, 5788.82633520995, 13547.796783048263, 13630.386632601556, 13637.522686705917, 13811.585652430444, 13830.446782128703, 2088.2691058129685, 2150.8386870984737, 2210.8452408331423, 2382.404398900275, 2620.5021046001198, 9131.36080474367, 9872.90127098727, 9919.3056486046, 9932.424327242186, 10463.84304235437, 1949.7952714964865, 1950.1809240119042, 2000.109951071759, 2024.7975202479633, 2045.9795402046086, 71903.0, 73702.26297737008, 74022.25977740207, 74428.62785686037, 76570.61714691446, 10748.731281718019, 10759.83860242097, 10963.616273430393, 11101.44492775358, 11107.777844443228, 15083.54749357521, 15089.54731358061, 15091.320890559951, 15122.697546049238, 15135.772963405558, 7685.615719214017, 8127.187281271944, 8128.187181281824, 8368.163183681583, 8375.916240837636, 7763.650635721406, 7764.0, 7775.261350171838, 7907.446478746548, 8012.3590112790835, 4610.101030299126, 4663.48701642819, 4697.506761790031, 4760.928586071212, 4808.9519104808505, 1928.8595891948082, 1933.9033048347808, 1998.8906157082668, 2007.5081605006867, 2053.363457328233, 922.6770630279349, 931.8182954323842, 993.3642468819961, 1021.1830535571513, 1075.800976819291, 17358.479245622653, 18427.26290948374, 18706.71939920902, 18777.718334225, 18949.62100757977, 927.7773334399695, 935.3826474526779, 963.4700914496999, 984.6799790068256, 993.761497240657, 7751.92248077512, 10092.495375231209, 10537.262391632512, 10539.0, 10605.84091238632, 394486.0, 396783.0, 401459.0, 403695.0, 404195.0, 53216.0, 55492.84368079303, 79961.60019199867, 83281.0, 85974.14025859786, 941.6374695742052, 953.6995846308529, 991.6430085169477, 991.74214704176, 992.3500107429645, 16484.34062637529, 16659.583510412336, 16827.579310516845, 16971.066591337596, 17116.743248851028, 37946.43080353742, 39260.0, 39305.41041884317, 39585.2082958345, 39978.400323995746, 52189.7390513045, 52338.47661523336, 52572.21141682801, 53792.462075378746, 54229.0, 7412.8146796328365, 7736.994190755166, 8201.384896132933, 8364.330853531581, 8540.786480338042, 12298.0, 12760.0, 12908.870911291142, 13138.73722525525, 13211.735765284448, 10956.0, 11188.440577971232, 11344.319340839576, 11499.195056345976, 11640.0, 10889.237753357189, 10991.945040274748, 11085.390303533382, 11196.776064478501, 11708.356040417859, 11211.55153793839, 11382.487788049391, 11420.257683250562, 11516.120969757561, 11652.825207621723, 7402.703891844266, 7679.232076792276, 7767.844643106993, 7874.251946065115, 8069.072056713553, 8968.0, 10530.210234232616, 11124.0, 11162.832557511807, 11411.201215914807], "value": 8712.904513582238, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.5428662827892, 1438.8633079857414, 1590.6341541445468, 1685.772420723202, 1752.4217008387234, 7744.961275193623, 8105.189481051899, 8110.878336824952, 8137.471064380811, 8151.266386025257, 7302.561846289226, 7502.0, 7752.147263800977, 8003.159668234839, 8058.073321568021, 2218.7004754358195, 2247.516783891463, 2248.3704562722464, 2254.413852398372, 2257.1535674122206, 2269.1263863412623, 2299.4366380236866, 2332.941676458085, 2334.1013709721797, 2341.8594884306913, 2275.2719129878446, 2278.1798552521077, 2278.4303924018996, 2298.9540209195807, 2305.5158416732506, 2239.518503521734, 2255.6842042114117, 2273.0453209651987, 2273.1702928431087, 2277.6241920083166, 2233.7654546272734, 2254.3800454874877, 2260.107257633242, 2260.378395941113, 2261.536385041079, 8083.232092951161, 8091.433599648027, 8190.058143313536, 8195.303399211074, 8200.548969806658, 4854.2718592211095, 4952.405711314629, 4989.151844186497, 4989.750512474362, 4992.450830408652, 2980.687027862065, 3055.5263934090253, 3279.918002049944, 3285.195127193853, 3300.1584595927884, 960.6685693435824, 966.9033096690345, 975.6000039983644, 984.458547798715, 1010.6765834932825, 10983.505742241618, 10985.890141098567, 10989.670309890716, 10992.615258465996, 11019.393933333664, 4167.395727619478, 4399.23013472641, 4447.132809102194, 4449.377087207794, 4476.619487343547, 9489.240860731124, 9490.383125096847, 9491.90508094924, 9491.952540237255, 9493.525323733924, 5034.622403319766, 5040.949590504121, 5043.722595257296, 5044.974775126174, 5050.873728156752, 4466.454121150978, 4525.796339164745, 4630.398048253705, 4631.907361852744, 4646.233371493733, 3817.751846129993, 3869.941950870739, 3882.2235552889533, 3962.2867883781196, 4092.9386059209137, 1265.8354413926131, 1291.141390974991, 1297.7599144158362, 1305.549585393038, 1311.8819306262483, 790.561238512631, 846.7798372423214, 877.8727084572702, 906.0622255965045, 916.1251005289932, 5426.8371948841595, 5443.2107344434835, 5532.1425179097305, 5616.97191514048, 5707.1153971134545, 891.4695756025154, 955.6273053509137, 958.1616085924816, 982.3320142303303, 1062.3360399750156, 3565.3938830398893, 3777.338965680995, 3796.487474191004, 3799.1072098056934, 3937.114149316381, 9733.853992190123, 10035.548400322003, 10039.14667253277, 10043.4476103815, 10050.346727462691, 9628.374155679858, 9762.560684769202, 9865.556049977768, 9966.80066398668, 10001.099901008944, 7598.240175982358, 7679.462437629312, 7695.0, 7704.383649308042, 7728.18854020331, 5451.972740136274, 5460.453954604508, 5515.393306736176, 5534.169874518854, 5584.664920104807, 8969.641214351353, 8981.595828187877, 9037.005929347635, 9046.819063618823, 9140.131687489678, 8842.823143536965, 9050.954745226232, 9099.317551183556, 9341.346105772802, 9438.622455101719, 6994.055802466602, 7139.286071392819, 7142.678579463833, 7142.9285707144345, 7143.1428228612895, 7921.049474063149, 7951.324137448381, 8000.51996880189, 8005.319547838266, 8007.599620019092, 7068.611226382598, 7100.502964792415, 7214.819629509304, 7223.422126229994, 7370.852582948418, 7032.050673159058, 7113.608751518716, 7128.821779455555, 7139.143302803489, 7150.427965762622, 5915.615484993462, 6004.39956004396, 6036.939630603638, 6081.057436097412, 6166.105914642441, 4290.50659174199, 4363.280058790264, 4429.756363399915, 4464.084862603094, 4639.2113340731485, 4485.282354823213, 4503.414556107816, 4577.153226653079, 4621.191291523903, 4642.234031384919], "value": 4337.194371688573, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.461434776097, 385.72613444454436, 387.86424751337034, 388.80365415465184, 399.8360672124428, 5078.492150784924, 5208.38540052583, 5231.424543300239, 5241.187615919529, 5325.3077099977045, 5214.973925130378, 5240.37115546134, 5265.419944227329, 5319.7340132993295, 5327.334083239595, 4220.36694495825, 4222.429971953793, 4234.322508398657, 4236.449261595988, 4260.957390426102, 4031.2945234583976, 4067.430559721641, 4131.752094874302, 4170.186813571355, 4230.757698419827, 4190.9580904191025, 4192.37114432836, 4199.7690127043, 4202.474690663667, 4222.746635201883, 4202.747835129902, 4206.221848957953, 4218.831246750157, 4224.408582798411, 4224.767637779921, 3598.946015809765, 3622.3660859349507, 3716.2567486502808, 3719.293334266508, 3751.924961500782, 5063.367079115111, 5089.312942752755, 5092.159793634083, 5101.489851014869, 5107.7446127693465, 4775.307580400857, 4780.569748722597, 4812.711237325771, 4843.273508973647, 4869.220924652039, 5328.706921119337, 5417.1852429436185, 5435.1847222916485, 5458.918116228259, 5473.452654734535, 4136.131412403399, 4145.647619952308, 4150.418941348214, 4154.626083652486, 4167.1457351242925, 5716.0, 5758.769649214027, 5767.365589785162, 5770.596058275923, 5772.220750198711, 4144.544100148981, 4211.873643790691, 4239.342901850218, 4250.44858626599, 4256.510501292391, 4296.871093867189, 4312.849050283225, 4313.352997050468, 4343.0, 4344.674149438804, 4617.884552886205, 4664.183767840615, 4723.551262630044, 4804.375431193923, 4828.561576403964, 5421.213923981, 5435.320584926884, 5437.374701909331, 5460.645058071213, 5467.0, 1431.6921861799763, 1441.7693169092895, 1449.2029383838847, 1449.8256412306066, 1463.7584798508126, 917.958691858868, 954.8185844689486, 962.4465932089076, 963.9204091417517, 966.7341481092756, 5095.0574143783515, 5105.183170692671, 5109.540141387293, 5132.28148059272, 5140.298984730987, 5447.046766815792, 5461.542305962333, 5489.0, 5490.890182196334, 5527.517663871735, 5024.371953505812, 5132.666376685504, 5214.60890433219, 5251.142693008951, 5280.498352656491, 2872.0809341010677, 2886.3794284228993, 2892.1901867476718, 2893.7284231877875, 2900.8404537750625, 5661.830145095571, 5695.971520142372, 5704.229928959538, 5718.79984200551, 5771.769129234784, 5773.191753154561, 5777.19119323295, 5801.680907550125, 5812.389699081536, 5815.73829177688, 5899.439553242435, 5923.0, 5929.288485381781, 5950.583459157818, 5982.102684597258, 5471.23402723627, 5613.550915926634, 5647.209390685225, 5660.660360378391, 5709.486146246858, 5589.664620122806, 5605.467480589337, 5623.465770751772, 5658.886822263614, 5661.858453538694, 5673.489385955284, 5920.526357891445, 5947.672877991579, 5954.612950158225, 5961.52307815365, 4066.0, 4089.2230476209425, 4106.445629839934, 4128.855490057834, 4129.545749967561, 5493.807716729895, 5530.668159910419, 5625.184348269559, 5687.687177205294, 5707.514861236841, 5479.972600137134, 5483.259759932358, 5486.533644640251, 5506.889862202814, 5517.393086760373, 5448.591355648421, 5455.854270603218, 5471.671699698031, 5480.150576660624, 5489.890202196014, 5233.241180028951, 5407.567394608501, 5459.7270136492225, 5490.298007617651, 5505.256790333414, 5464.235007099089, 5495.505404513613, 5520.53075488588, 5534.335879694462, 5564.4713752193475, 5236.319278493771, 5365.543928765943, 5380.246765452762, 5395.325584301962, 5442.292501974718], "value": 4250.721215498927, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.8452332748458, 744.8175197076717, 766.4060353226249, 775.5618075787177, 860.681547827304, 15918.840811591881, 16716.331346746116, 16785.66428671426, 16849.747253791204, 17028.829711702896, 12150.270983740982, 15165.165915874622, 15199.77200341993, 15378.84621153788, 15404.075755454653, 823.3454403749018, 846.0439703135448, 848.0713618587637, 848.9981821450685, 849.0617867256685, 835.4611275727152, 839.3872473094644, 840.0549381945311, 843.641452382738, 843.7215718812807, 866.0646501778097, 874.807542340684, 881.3566096749377, 881.8104107616861, 883.4699180491718, 877.609463788608, 878.2622597018471, 879.151618687966, 879.5118709116438, 880.7842078690697, 629.7386584567445, 634.6065439427538, 634.6287421858218, 635.9300476947532, 646.6281887914421, 15682.294296756674, 15682.68634627301, 15714.68570628581, 15719.214039298104, 15770.842291577166, 14121.929390353085, 15059.924700376429, 15439.382424702999, 15516.301766420538, 15649.452269170639, 12187.32969686667, 12376.195547289397, 12400.503979840796, 12533.623991280276, 12560.81158782619, 3725.832337544817, 3832.5209348831395, 3856.633619806114, 3857.8263978121054, 3993.7603743775176, 68705.65647171732, 69483.0, 69793.30206697919, 79616.60191699062, 84298.57850710768, 11631.418429078512, 11671.416429178507, 11771.352575608424, 11861.11041671878, 12436.875631243753, 21355.67966480504, 21365.67951480729, 21513.67729484059, 21572.784272157078, 21711.457213569785, 7249.528780629348, 7457.403407727369, 7483.214262502359, 8447.831043379098, 8452.197041281068, 4422.09347083847, 4561.110583436198, 4577.130345234461, 4609.285560738091, 4649.767511624405, 3516.2791627716256, 3526.613143027029, 3572.8749493767596, 3611.6930060944587, 3687.1335236219466, 677.6108976597955, 683.5386114372878, 689.3106893106893, 699.464909344352, 701.9227884932653, 725.354434553248, 727.058459295214, 749.0, 762.9771106866802, 769.3960241210734, 9649.614015439443, 10103.545340459697, 10220.744481388025, 10656.413897235572, 11048.834267485994, 541.6777017674477, 712.4407340237889, 712.4478529139958, 768.0322793280395, 781.4100354232518, 4481.215787237221, 5137.640365174477, 5142.434332223453, 5149.742512874416, 5149.76826042829, 83342.74985875217, 83640.58179709184, 86415.56792215999, 87523.0, 87905.1209487897, 42408.36387454191, 46600.7669961648, 54665.453345466834, 60481.092783608285, 75469.0, 61020.032788196215, 61516.38483615196, 61994.0, 62841.0, 63887.68056159689, 9888.406695598287, 10035.29752917318, 10291.22815788804, 10331.32846364984, 10602.469876506299, 37988.43017354687, 42535.760857663474, 42540.36189457099, 44567.0, 44912.0, 54013.189802153785, 58609.12086318623, 58779.4122058791, 59104.408955909894, 61267.38732612617, 11667.883321166679, 12539.24764514132, 12678.842618495664, 13389.330533473481, 13478.258695771827, 14829.851701482847, 14883.851161488246, 15131.319090640727, 15176.468823591122, 15437.382504699686, 12960.0, 13640.590782276548, 13792.586222413343, 14252.216128113054, 14367.0, 12613.0, 12658.43037063316, 12769.361531923181, 12889.935550322189, 13794.448222071005, 13233.0, 13781.724365512835, 13977.650558735706, 14217.0, 14274.14355138695, 11172.0, 11249.268797528135, 11632.88367116318, 11714.414279286171, 12196.268223906594, 10446.843297350393, 10452.947735261276, 11283.004537186669, 11629.0, 11687.84571684849], "value": 7358.942472817655, "unit": "score"}], "name": "dromaeo_css", "value": 7080.614109889351, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 111.0, 111.0, 113.0, 113.0, 111.0, 111.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 120.0, 161.0, 144.0, 121.0, 123.0, 120.0, 141.0, 122.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 158.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 115.0, 77.0, 76.0, 76.0, 75.0, 89.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 84.0, 83.0, 84.0, 96.0, 83.0, 83.0, 102.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 50.0, 50.0, 52.0, 51.0, 51.0, 50.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 85.0, 80.0, 85.0, 87.0, 80.0, 85.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 126.0, 129.0, 128.0, 126.0, 130.0, 132.0, 126.0, 158.0, 135.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 163.0, 167.0, 164.0, 167.0, 168.0, 166.0, 164.0, 167.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 62.0, 65.0, 61.0, 64.0, 64.0, 63.0, 61.0, 72.0, 59.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1495.1000000000001, "alertThreshold": 2.0}]} 11:53:54 INFO - Return code: 0 11:53:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:53:54 INFO - # TBPL SUCCESS # 11:53:54 INFO - Running post-action listener: _resource_record_post_action 11:53:54 INFO - [mozharness: 2016-12-22 19:53:54.268212Z] Finished run-tests step (success) 11:53:54 INFO - Running post-run listener: _resource_record_post_run 11:53:54 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 401752064; Read time: 28; Write time: 250068 11:53:54 INFO - TinderboxPrint: CPU usage
13.1% 11:53:54 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 11:53:54 INFO - TinderboxPrint: I/O write bytes / time
401,752,064 / 250,068 11:53:54 INFO - TinderboxPrint: CPU idle
8,282.9 (86.9%) 11:53:54 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 11:53:54 INFO - TinderboxPrint: Swap in / out
0 / 0 11:53:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105091072; Read time: 0; Write time: 78280 11:53:54 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296165376; Read time: 16; Write time: 171760 11:53:54 INFO - Running post-run listener: _upload_blobber_files 11:53:54 INFO - Blob upload gear active. 11:53:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:53:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:53:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:53:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:53:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:53:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:56 INFO - (blobuploader) - INFO - Done attempting. 11:53:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:53:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:53:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:57 INFO - (blobuploader) - INFO - Done attempting. 11:53:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:53:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:00 INFO - (blobuploader) - INFO - Done attempting. 11:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:01 INFO - (blobuploader) - INFO - Done attempting. 11:54:01 INFO - (blobuploader) - INFO - Iteration through files over. 11:54:01 INFO - Return code: 0 11:54:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:54:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:54:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c6d3052c0f5e22bbdefdeec642446a712da4be380dd88fbb9508f8bf9dcde766d18515f1cf20344a943a583a726e720817b360ac9eed34f3fd7456b5676793e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/989c86f00d240845d6b55e0c780a9af622051abc320c8faa08cc8fb91d28fa40825ce41d3377243e412ffb43522a967f131546667d81eb9a9bddf5c6272381eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de029a8e7ab53cc60237becff2d709b441b990eb03ec596eed255d080e5f2c1df913721ca24c2c71d79d49d8595982c0a12c6891c046e85b999fee43640acff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e9200ee602f101df94a8caa3d949b42c30fd4a033fd72fdd2f625a9d57e77e9ce16741e931e8aa9dfaa3f2264c6b823beff094f75ebdf55466afd89c2ca5f5aa"} 11:54:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:54:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:54:01 INFO - Contents: 11:54:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c6d3052c0f5e22bbdefdeec642446a712da4be380dd88fbb9508f8bf9dcde766d18515f1cf20344a943a583a726e720817b360ac9eed34f3fd7456b5676793e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/989c86f00d240845d6b55e0c780a9af622051abc320c8faa08cc8fb91d28fa40825ce41d3377243e412ffb43522a967f131546667d81eb9a9bddf5c6272381eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de029a8e7ab53cc60237becff2d709b441b990eb03ec596eed255d080e5f2c1df913721ca24c2c71d79d49d8595982c0a12c6891c046e85b999fee43640acff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e9200ee602f101df94a8caa3d949b42c30fd4a033fd72fdd2f625a9d57e77e9ce16741e931e8aa9dfaa3f2264c6b823beff094f75ebdf55466afd89c2ca5f5aa"} 11:54:01 INFO - Running post-run listener: copy_logs_to_upload_dir 11:54:01 INFO - Copying logs to upload dir... 11:54:01 INFO - mkdir: /builds/slave/test/build/upload/logs 11:54:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.152214 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-22 11:54:01.200299) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 11:54:01.203967) ========= 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=836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c6d3052c0f5e22bbdefdeec642446a712da4be380dd88fbb9508f8bf9dcde766d18515f1cf20344a943a583a726e720817b360ac9eed34f3fd7456b5676793e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/989c86f00d240845d6b55e0c780a9af622051abc320c8faa08cc8fb91d28fa40825ce41d3377243e412ffb43522a967f131546667d81eb9a9bddf5c6272381eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de029a8e7ab53cc60237becff2d709b441b990eb03ec596eed255d080e5f2c1df913721ca24c2c71d79d49d8595982c0a12c6891c046e85b999fee43640acff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e9200ee602f101df94a8caa3d949b42c30fd4a033fd72fdd2f625a9d57e77e9ce16741e931e8aa9dfaa3f2264c6b823beff094f75ebdf55466afd89c2ca5f5aa"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1482428150/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c6d3052c0f5e22bbdefdeec642446a712da4be380dd88fbb9508f8bf9dcde766d18515f1cf20344a943a583a726e720817b360ac9eed34f3fd7456b5676793e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/989c86f00d240845d6b55e0c780a9af622051abc320c8faa08cc8fb91d28fa40825ce41d3377243e412ffb43522a967f131546667d81eb9a9bddf5c6272381eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de029a8e7ab53cc60237becff2d709b441b990eb03ec596eed255d080e5f2c1df913721ca24c2c71d79d49d8595982c0a12c6891c046e85b999fee43640acff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e9200ee602f101df94a8caa3d949b42c30fd4a033fd72fdd2f625a9d57e77e9ce16741e931e8aa9dfaa3f2264c6b823beff094f75ebdf55466afd89c2ca5f5aa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 11:54:01.230886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 11:54:01.231413) ========= 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=836cfdc75598d54cb747368e000001a9-1482435202.452433-536816453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 11:54:01.315370) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 11:54:01.315697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 11:54:01.316028) ========= ========= Total master_lag: 0.18 =========