builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1484155705.43 results: success (0) buildid: 20170111081751 builduid: fcdc666f2c56495da781733f9756a0fe revision: c98510adc780b5d67acc1bbf79568e2abc03450b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:25.433085) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:25.433607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:25.433917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:25.448647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:25.448990) ========= 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=0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-11 09:28:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2017-01-11 09:28:25 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146543 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:25.609726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:25.610118) ========= 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=0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013643 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:25.660308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 09:28:25.660703) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c98510adc780b5d67acc1bbf79568e2abc03450b --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 c98510adc780b5d67acc1bbf79568e2abc03450b --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=0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-11 09:28:25,728 truncating revision to first 12 chars 2017-01-11 09:28:25,728 Setting DEBUG logging. 2017-01-11 09:28:25,728 attempt 1/10 2017-01-11 09:28:25,728 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c98510adc780?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 09:28:26,524 unpacking tar archive at: mozilla-inbound-c98510adc780/testing/mozharness/ program finished with exit code 0 elapsedTime=1.104171 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 09:28:26.779291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:26.779702) ========= script_repo_revision: c98510adc780b5d67acc1bbf79568e2abc03450b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:26.780175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:26.780477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 09:28:26.790360) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-11 09:28:26.790795) ========= /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=0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:28:26 INFO - MultiFileLogger online at 20170111 09:28:26 in /builds/slave/test 09:28:26 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 09:28:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:28:26 INFO - {'append_to_log': False, 09:28:26 INFO - 'base_work_dir': '/builds/slave/test', 09:28:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:28:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:28:26 INFO - 'branch': 'Mozilla-Inbound', 09:28:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:28:26 INFO - 'config_files': ('talos/linux_config.py',), 09:28:26 INFO - 'default_actions': ('clobber', 09:28:26 INFO - 'read-buildbot-config', 09:28:26 INFO - 'download-and-extract', 09:28:26 INFO - 'populate-webroot', 09:28:26 INFO - 'create-virtualenv', 09:28:26 INFO - 'install', 09:28:26 INFO - 'run-tests'), 09:28:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:28:26 INFO - 'download_minidump_stackwalk': True, 09:28:26 INFO - 'download_symbols': 'ondemand', 09:28:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:28:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:28:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:28:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:28:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:28:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:28:26 INFO - 'installer_path': 'installer.exe', 09:28:26 INFO - 'log_level': 'info', 09:28:26 INFO - 'log_name': 'talos', 09:28:26 INFO - 'log_to_console': True, 09:28:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:28:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:28:26 INFO - 'opt_config_files': (), 09:28:26 INFO - 'pip_index': False, 09:28:26 INFO - 'sps_profile': False, 09:28:26 INFO - 'sps_profile_interval': 0, 09:28:26 INFO - 'suite': 'dromaeojs', 09:28:26 INFO - 'system_bits': '32', 09:28:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:28:26 INFO - 'title': 'talos-linux64-ix-017', 09:28:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:28:26 INFO - 'use_talos_json': True, 09:28:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:28:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:28:26 INFO - 'work_dir': 'build'} 09:28:26 INFO - [mozharness: 2017-01-11 17:28:26.956831Z] Running clobber step. 09:28:26 INFO - Running pre-action listener: _resource_record_pre_action 09:28:26 INFO - Running main action method: clobber 09:28:26 INFO - rmtree: /builds/slave/test/build 09:28:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:28:27 INFO - Running post-action listener: _resource_record_post_action 09:28:27 INFO - [mozharness: 2017-01-11 17:28:27.438133Z] Finished clobber step (success) 09:28:27 INFO - [mozharness: 2017-01-11 17:28:27.438235Z] Running read-buildbot-config step. 09:28:27 INFO - Running pre-action listener: _resource_record_pre_action 09:28:27 INFO - Running main action method: read_buildbot_config 09:28:27 INFO - Using buildbot properties: 09:28:27 INFO - { 09:28:27 INFO - "project": "", 09:28:27 INFO - "product": "firefox", 09:28:27 INFO - "script_repo_revision": "production", 09:28:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:28:27 INFO - "repository": "", 09:28:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:28:27 INFO - "buildid": "20170111081751", 09:28:27 INFO - "stage_platform": "linux64-pgo", 09:28:27 INFO - "basedir": "/builds/slave/test", 09:28:27 INFO - "buildnumber": 2431, 09:28:27 INFO - "platform": "ubuntu64_hw", 09:28:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:28:27 INFO - "slavebuilddir": "test", 09:28:27 INFO - "branch": "mozilla-inbound", 09:28:27 INFO - "revision": "c98510adc780b5d67acc1bbf79568e2abc03450b", 09:28:27 INFO - "slavename": "talos-linux64-ix-017", 09:28:27 INFO - "builduid": "fcdc666f2c56495da781733f9756a0fe", 09:28:27 INFO - "repo_path": "integration/mozilla-inbound" 09:28:27 INFO - } 09:28:27 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 09:28:27 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 09:28:27 INFO - Running post-action listener: _resource_record_post_action 09:28:27 INFO - [mozharness: 2017-01-11 17:28:27.440605Z] Finished read-buildbot-config step (success) 09:28:27 INFO - [mozharness: 2017-01-11 17:28:27.440694Z] Running download-and-extract step. 09:28:27 INFO - Running pre-action listener: _resource_record_pre_action 09:28:27 INFO - Running main action method: download_and_extract 09:28:27 INFO - mkdir: /builds/slave/test/build/tests 09:28:27 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')]} 09:28:27 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:28:27 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/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 09:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/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 09:28:27 INFO - Downloaded 1361 bytes. 09:28:27 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:28:27 INFO - Using the following test package requirements: 09:28:27 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:28:27 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:28:27 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:28:27 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:27 INFO - u'jsshell-linux-x86_64.zip'], 09:28:27 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:28:27 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:28:27 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:28:27 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:28:27 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:28:27 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:28:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:28:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:28:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:28:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:28:27 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:28:27 INFO - Expected file size: 21848533 09:28:27 INFO - Obtained file size: 21848533 09:28:31 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 09:28:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:28:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:28:31 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:28:31 INFO - Expected file size: 21848533 09:28:31 INFO - Obtained file size: 21848533 09:28:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 09:28:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:28:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:28:36 INFO - Expected file size: 14403529 09:28:36 INFO - Obtained file size: 14403529 09:28:36 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')]} 09:28:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:28:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/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 09:28:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/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 09:28:37 INFO - Downloaded 61520591 bytes. 09:28:37 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:28:37 INFO - mkdir: /builds/slave/test/properties 09:28:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:28:37 INFO - Writing to file /builds/slave/test/properties/build_url 09:28:37 INFO - Contents: 09:28:37 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:28:37 INFO - Running post-action listener: _resource_record_post_action 09:28:37 INFO - Running post-action listener: set_extra_try_arguments 09:28:37 INFO - [mozharness: 2017-01-11 17:28:37.835683Z] Finished download-and-extract step (success) 09:28:37 INFO - [mozharness: 2017-01-11 17:28:37.835911Z] Running populate-webroot step. 09:28:37 INFO - Running pre-action listener: _resource_record_pre_action 09:28:37 INFO - Running main action method: populate_webroot 09:28:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:28:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:28:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:28:37 INFO - '--tppagecycles', 09:28:37 INFO - '7'], 09:28:37 INFO - 'tests': ['tsvgm']}}, 09:28:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:28:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:28:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:28:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:28:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:28:37 INFO - 'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:28:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:28:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:28:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:28:37 INFO - 'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['damp', 'tps']}, 09:28:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:28:37 INFO - 'tests': ['damp', 'tps']}, 09:28:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['dromaeo_dom']}, 09:28:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:28:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['basic_compositor_video']}, 09:28:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:28:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['a11yr', 09:28:37 INFO - 'ts_paint', 09:28:37 INFO - 'tpaint', 09:28:37 INFO - 'sessionrestore', 09:28:37 INFO - 'sessionrestore_no_auto_restore', 09:28:37 INFO - 'tabpaint']}, 09:28:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:28:37 INFO - 'ts_paint', 09:28:37 INFO - 'tpaint', 09:28:37 INFO - 'sessionrestore', 09:28:37 INFO - 'sessionrestore_no_auto_restore', 09:28:37 INFO - 'tabpaint']}, 09:28:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:28:37 INFO - 'ts_paint', 09:28:37 INFO - 'tpaint', 09:28:37 INFO - 'sessionrestore', 09:28:37 INFO - 'sessionrestore_no_auto_restore', 09:28:37 INFO - 'tabpaint']}, 09:28:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:28:37 INFO - 'ts_paint', 09:28:37 INFO - 'tpaint', 09:28:37 INFO - 'sessionrestore', 09:28:37 INFO - 'sessionrestore_no_auto_restore', 09:28:37 INFO - 'tabpaint']}, 09:28:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['a11yr', 09:28:37 INFO - 'ts_paint', 09:28:37 INFO - 'tpaint', 09:28:37 INFO - 'sessionrestore', 09:28:37 INFO - 'sessionrestore_no_auto_restore', 09:28:37 INFO - 'tabpaint']}, 09:28:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['a11yr', 09:28:37 INFO - 'ts_paint', 09:28:37 INFO - 'tpaint', 09:28:37 INFO - 'sessionrestore', 09:28:37 INFO - 'sessionrestore_no_auto_restore', 09:28:37 INFO - 'tabpaint']}, 09:28:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['tsvgx', 09:28:37 INFO - 'tsvgr_opacity', 09:28:37 INFO - 'tart', 09:28:37 INFO - 'tscrollx', 09:28:37 INFO - 'cart', 09:28:37 INFO - 'tsvg_static']}, 09:28:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:28:37 INFO - 'tsvgr_opacity', 09:28:37 INFO - 'tart', 09:28:37 INFO - 'tscrollx', 09:28:37 INFO - 'cart', 09:28:37 INFO - 'tsvg_static']}, 09:28:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:28:37 INFO - 'talos_options': ['--disable-e10s'], 09:28:37 INFO - 'tests': ['tp5o']}, 09:28:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:28:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:28:37 INFO - 'talos_options': ['--disable-e10s', 09:28:37 INFO - '--xperf_path', 09:28:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:28:37 INFO - 'tests': ['tp5n']}, 09:28:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:28:37 INFO - 'talos_options': ['--xperf_path', 09:28:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:28:37 INFO - 'tests': ['tp5n']}}, 09:28:37 INFO - 'talos.zip': {'path': '', 09:28:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:28:37 INFO - Running post-action listener: _resource_record_post_action 09:28:37 INFO - [mozharness: 2017-01-11 17:28:37.857566Z] Finished populate-webroot step (success) 09:28:37 INFO - [mozharness: 2017-01-11 17:28:37.857655Z] Running create-virtualenv step. 09:28:37 INFO - Running pre-action listener: _resource_record_pre_action 09:28:37 INFO - Running main action method: create_virtualenv 09:28:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:28:37 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 09:28:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:28:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:28:37 INFO - Using real prefix '/usr' 09:28:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:28:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:28:40 INFO - Installing pip.................done. 09:28:40 INFO - Return code: 0 09:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:28:40 INFO - Reading from file tmpfile_stdout 09:28:40 INFO - Output received: 09:28:40 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) 09:28:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, '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': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', '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 09:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:28:40 INFO - Using env: {'DISPLAY': ':0', 09:28:40 INFO - 'HOME': '/home/cltbld', 09:28:40 INFO - 'LANG': 'en_US.UTF-8', 09:28:40 INFO - 'LANGUAGE': 'en_US:en', 09:28:40 INFO - 'LOGNAME': 'cltbld', 09:28:40 INFO - 'MAIL': '/var/mail/cltbld', 09:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:40 INFO - 'MOZ_NO_REMOTE': '1', 09:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:40 INFO - 'NO_EM_RESTART': '1', 09:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:40 INFO - 'PWD': '/builds/slave/test', 09:28:40 INFO - 'SHELL': '/bin/bash', 09:28:40 INFO - 'SHLVL': '1', 09:28:40 INFO - 'TERM': 'linux', 09:28:40 INFO - 'TMOUT': '86400', 09:28:40 INFO - 'USER': 'cltbld', 09:28:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:40 INFO - '_': '/tools/buildbot/bin/python'} 09:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:40 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 09:28:40 INFO - Cleaning up... 09:28:40 INFO - Return code: 0 09:28:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, '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': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', '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 09:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:28:40 INFO - Using env: {'DISPLAY': ':0', 09:28:40 INFO - 'HOME': '/home/cltbld', 09:28:40 INFO - 'LANG': 'en_US.UTF-8', 09:28:40 INFO - 'LANGUAGE': 'en_US:en', 09:28:40 INFO - 'LOGNAME': 'cltbld', 09:28:40 INFO - 'MAIL': '/var/mail/cltbld', 09:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:40 INFO - 'MOZ_NO_REMOTE': '1', 09:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:40 INFO - 'NO_EM_RESTART': '1', 09:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:40 INFO - 'PWD': '/builds/slave/test', 09:28:40 INFO - 'SHELL': '/bin/bash', 09:28:40 INFO - 'SHLVL': '1', 09:28:40 INFO - 'TERM': 'linux', 09:28:40 INFO - 'TMOUT': '86400', 09:28:40 INFO - 'USER': 'cltbld', 09:28:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:40 INFO - '_': '/tools/buildbot/bin/python'} 09:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:41 INFO - Downloading/unpacking psutil>=3.1.1 09:28:41 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 09:28:41 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 09:28:41 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 09:28:41 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 09:28:41 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 09:28:41 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 09:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:28:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:28:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:28:43 INFO - Installing collected packages: psutil 09:28:43 INFO - Running setup.py install for psutil 09:28:43 INFO - building 'psutil._psutil_linux' extension 09:28:43 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 09:28:43 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 09:28:43 INFO - building 'psutil._psutil_posix' extension 09:28:43 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 09:28:43 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 09:28:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:28:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:28:43 INFO - Successfully installed psutil 09:28:43 INFO - Cleaning up... 09:28:43 INFO - Return code: 0 09:28:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:28:43 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')]} 09:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:43 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')]} 09:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:43 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 0x19e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, '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': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', '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 09:28:43 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 09:28:43 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 09:28:43 INFO - Using env: {'DISPLAY': ':0', 09:28:43 INFO - 'HOME': '/home/cltbld', 09:28:43 INFO - 'LANG': 'en_US.UTF-8', 09:28:43 INFO - 'LANGUAGE': 'en_US:en', 09:28:43 INFO - 'LOGNAME': 'cltbld', 09:28:43 INFO - 'MAIL': '/var/mail/cltbld', 09:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:43 INFO - 'MOZ_NO_REMOTE': '1', 09:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:43 INFO - 'NO_EM_RESTART': '1', 09:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:43 INFO - 'PWD': '/builds/slave/test', 09:28:43 INFO - 'SHELL': '/bin/bash', 09:28:43 INFO - 'SHLVL': '1', 09:28:43 INFO - 'TERM': 'linux', 09:28:43 INFO - 'TMOUT': '86400', 09:28:43 INFO - 'USER': 'cltbld', 09:28:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:43 INFO - '_': '/tools/buildbot/bin/python'} 09:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:28: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 09:28: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 09:28: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 09:28: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 09:28: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 09:28: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 09:28:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:28:46 INFO - Installing collected packages: mozsystemmonitor 09:28:46 INFO - Running setup.py install for mozsystemmonitor 09:28:46 INFO - Successfully installed mozsystemmonitor 09:28:46 INFO - Cleaning up... 09:28:46 INFO - Return code: 0 09:28:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, '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': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', '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 09:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:28:46 INFO - Using env: {'DISPLAY': ':0', 09:28:46 INFO - 'HOME': '/home/cltbld', 09:28:46 INFO - 'LANG': 'en_US.UTF-8', 09:28:46 INFO - 'LANGUAGE': 'en_US:en', 09:28:46 INFO - 'LOGNAME': 'cltbld', 09:28:46 INFO - 'MAIL': '/var/mail/cltbld', 09:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:46 INFO - 'MOZ_NO_REMOTE': '1', 09:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:46 INFO - 'NO_EM_RESTART': '1', 09:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:46 INFO - 'PWD': '/builds/slave/test', 09:28:46 INFO - 'SHELL': '/bin/bash', 09:28:46 INFO - 'SHLVL': '1', 09:28:46 INFO - 'TERM': 'linux', 09:28:46 INFO - 'TMOUT': '86400', 09:28:46 INFO - 'USER': 'cltbld', 09:28:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:46 INFO - '_': '/tools/buildbot/bin/python'} 09:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:46 INFO - Downloading/unpacking jsonschema==2.5.1 09:28:46 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 09:28:46 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 09:28:46 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 09:28:46 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 09:28:46 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 09:28:46 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 09:28:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:28:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:28: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 09:28: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 09:28: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 09:28: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 09:28: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 09:28: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 09:28:48 INFO - Downloading functools32-3.2.3-2.tar.gz 09:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:28:48 INFO - warning: no files found matching '*.txt' 09:28:48 INFO - no previously-included directories found matching 'build' 09:28:48 INFO - no previously-included directories found matching 'dist' 09:28:48 INFO - no previously-included directories found matching '.git*' 09:28:48 INFO - Installing collected packages: jsonschema, functools32 09:28:48 INFO - Running setup.py install for functools32 09:28:48 INFO - warning: no files found matching '*.txt' 09:28:48 INFO - no previously-included directories found matching 'build' 09:28:48 INFO - no previously-included directories found matching 'dist' 09:28:48 INFO - no previously-included directories found matching '.git*' 09:28:48 INFO - Successfully installed jsonschema functools32 09:28:48 INFO - Cleaning up... 09:28:48 INFO - Return code: 0 09:28:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:28: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')]} 09:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28: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')]} 09:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28: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 0x19e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, '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': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', '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 09:28: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 09:28: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 09:28:48 INFO - Using env: {'DISPLAY': ':0', 09:28:48 INFO - 'HOME': '/home/cltbld', 09:28:48 INFO - 'LANG': 'en_US.UTF-8', 09:28:48 INFO - 'LANGUAGE': 'en_US:en', 09:28:48 INFO - 'LOGNAME': 'cltbld', 09:28:48 INFO - 'MAIL': '/var/mail/cltbld', 09:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:48 INFO - 'MOZ_NO_REMOTE': '1', 09:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:48 INFO - 'NO_EM_RESTART': '1', 09:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:48 INFO - 'PWD': '/builds/slave/test', 09:28:48 INFO - 'SHELL': '/bin/bash', 09:28:48 INFO - 'SHLVL': '1', 09:28:48 INFO - 'TERM': 'linux', 09:28:48 INFO - 'TMOUT': '86400', 09:28:48 INFO - 'USER': 'cltbld', 09:28:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:48 INFO - '_': '/tools/buildbot/bin/python'} 09:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:28:49 INFO - Cleaning up... 09:28:49 INFO - Return code: 0 09:28:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:28:49 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')]} 09:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:49 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')]} 09:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:49 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 0x19e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, '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': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', '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 09:28:49 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 09:28:49 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 09:28:49 INFO - Using env: {'DISPLAY': ':0', 09:28:49 INFO - 'HOME': '/home/cltbld', 09:28:49 INFO - 'LANG': 'en_US.UTF-8', 09:28:49 INFO - 'LANGUAGE': 'en_US:en', 09:28:49 INFO - 'LOGNAME': 'cltbld', 09:28:49 INFO - 'MAIL': '/var/mail/cltbld', 09:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:49 INFO - 'MOZ_NO_REMOTE': '1', 09:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:49 INFO - 'NO_EM_RESTART': '1', 09:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:49 INFO - 'PWD': '/builds/slave/test', 09:28:49 INFO - 'SHELL': '/bin/bash', 09:28:49 INFO - 'SHLVL': '1', 09:28:49 INFO - 'TERM': 'linux', 09:28:49 INFO - 'TMOUT': '86400', 09:28:49 INFO - 'USER': 'cltbld', 09:28:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:49 INFO - '_': '/tools/buildbot/bin/python'} 09:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:49 INFO - Downloading/unpacking blobuploader==1.2.4 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:49 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 09:28:51 INFO - Downloading blobuploader-1.2.4.tar.gz 09:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:28:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:28: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 09:28: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 09:28: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 09:28: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 09:28: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 09:28: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 09:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:28:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:28: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 09:28: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 09:28:52 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 09:28:52 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 09:28:52 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 09:28:52 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 09:28:52 INFO - Downloading docopt-0.6.1.tar.gz 09:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:28:52 INFO - Installing collected packages: blobuploader, requests, docopt 09:28:52 INFO - Running setup.py install for blobuploader 09:28:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:28:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:28:52 INFO - Running setup.py install for requests 09:28:52 INFO - Running setup.py install for docopt 09:28:52 INFO - Successfully installed blobuploader requests docopt 09:28:52 INFO - Cleaning up... 09:28:52 INFO - Return code: 0 09:28:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28: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')]} 09:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28: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')]} 09:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28: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 0x19e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, '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': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', '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 09:28: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 09:28: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 09:28:52 INFO - Using env: {'DISPLAY': ':0', 09:28:52 INFO - 'HOME': '/home/cltbld', 09:28:52 INFO - 'LANG': 'en_US.UTF-8', 09:28:52 INFO - 'LANGUAGE': 'en_US:en', 09:28:52 INFO - 'LOGNAME': 'cltbld', 09:28:52 INFO - 'MAIL': '/var/mail/cltbld', 09:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:52 INFO - 'MOZ_NO_REMOTE': '1', 09:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:52 INFO - 'NO_EM_RESTART': '1', 09:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:52 INFO - 'PWD': '/builds/slave/test', 09:28:52 INFO - 'SHELL': '/bin/bash', 09:28:52 INFO - 'SHLVL': '1', 09:28:52 INFO - 'TERM': 'linux', 09:28:52 INFO - 'TMOUT': '86400', 09:28:52 INFO - 'USER': 'cltbld', 09:28:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:52 INFO - '_': '/tools/buildbot/bin/python'} 09:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:28:53 INFO - Running setup.py (path:/tmp/pip-aHAhjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:28:53 INFO - Running setup.py (path:/tmp/pip-5Klpn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:28:53 INFO - Running setup.py (path:/tmp/pip-HVZP6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:28:53 INFO - Running setup.py (path:/tmp/pip-Ew_03b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:28:53 INFO - Running setup.py (path:/tmp/pip-XGbGf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:28:53 INFO - Running setup.py (path:/tmp/pip-ErdCws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:28:53 INFO - Running setup.py (path:/tmp/pip-uKHI8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:28:53 INFO - Running setup.py (path:/tmp/pip-ZYDnUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:28:53 INFO - Running setup.py (path:/tmp/pip-K6UdaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:28:53 INFO - Running setup.py (path:/tmp/pip-ooKiWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:28:53 INFO - Running setup.py (path:/tmp/pip-FEPfuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:28:53 INFO - Running setup.py (path:/tmp/pip-QESMyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:28:53 INFO - Running setup.py (path:/tmp/pip-788JDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:28:54 INFO - Running setup.py (path:/tmp/pip-5k5uDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:54 INFO - Running setup.py (path:/tmp/pip-V0whkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:28:54 INFO - Running setup.py (path:/tmp/pip-HhevBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:28:54 INFO - Running setup.py (path:/tmp/pip-XFaXQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:28:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:28:54 INFO - Running setup.py install for manifestparser 09:28:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:28:54 INFO - Running setup.py install for mozcrash 09:28:54 INFO - Running setup.py install for mozdebug 09:28:54 INFO - Running setup.py install for mozdevice 09:28:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:28:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:28:54 INFO - Running setup.py install for mozfile 09:28:54 INFO - Running setup.py install for mozhttpd 09:28:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:28:54 INFO - Running setup.py install for mozinfo 09:28:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Running setup.py install for mozInstall 09:28:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Running setup.py install for mozleak 09:28:55 INFO - Running setup.py install for mozlog 09:28:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Running setup.py install for moznetwork 09:28:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Running setup.py install for mozprocess 09:28:55 INFO - Running setup.py install for mozprofile 09:28:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Running setup.py install for mozrunner 09:28:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:28:55 INFO - Running setup.py install for mozscreenshot 09:28:55 INFO - Running setup.py install for moztest 09:28:56 INFO - Running setup.py install for mozversion 09:28:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:28:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:28:56 INFO - Cleaning up... 09:28:56 INFO - Return code: 0 09:28:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28:56 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')]} 09:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:56 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')]} 09:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:56 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 0x19e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, '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': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', '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 09:28:56 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 09:28:56 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 09:28:56 INFO - Using env: {'DISPLAY': ':0', 09:28:56 INFO - 'HOME': '/home/cltbld', 09:28:56 INFO - 'LANG': 'en_US.UTF-8', 09:28:56 INFO - 'LANGUAGE': 'en_US:en', 09:28:56 INFO - 'LOGNAME': 'cltbld', 09:28:56 INFO - 'MAIL': '/var/mail/cltbld', 09:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:56 INFO - 'MOZ_NO_REMOTE': '1', 09:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:56 INFO - 'NO_EM_RESTART': '1', 09:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:56 INFO - 'PWD': '/builds/slave/test', 09:28:56 INFO - 'SHELL': '/bin/bash', 09:28:56 INFO - 'SHLVL': '1', 09:28:56 INFO - 'TERM': 'linux', 09:28:56 INFO - 'TMOUT': '86400', 09:28:56 INFO - 'USER': 'cltbld', 09:28:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:56 INFO - '_': '/tools/buildbot/bin/python'} 09:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:28:56 INFO - Running setup.py (path:/tmp/pip-rBRzIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:28:56 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)) 09:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:28:56 INFO - Running setup.py (path:/tmp/pip-dzjKFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:28:56 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)) 09:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:28:56 INFO - Running setup.py (path:/tmp/pip-yIyUki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:28:56 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)) 09:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:28:56 INFO - Running setup.py (path:/tmp/pip-18gCqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:28:56 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)) 09:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:28:56 INFO - Running setup.py (path:/tmp/pip-yuR3q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:28:56 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)) 09:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:28:56 INFO - Running setup.py (path:/tmp/pip-dI2Xh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:28:56 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)) 09:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:28:56 INFO - Running setup.py (path:/tmp/pip-e5ih0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:28: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)) 09:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:28:56 INFO - Running setup.py (path:/tmp/pip-QlCLPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:28: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)) 09:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:28:56 INFO - Running setup.py (path:/tmp/pip-hpYsN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:28:57 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)) 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:28:57 INFO - Running setup.py (path:/tmp/pip-CHZDS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:28:57 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)) 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:28:57 INFO - Running setup.py (path:/tmp/pip-b3ox7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:28:57 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)) 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:28:57 INFO - Running setup.py (path:/tmp/pip-R4mt88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:28:57 INFO - Running setup.py (path:/tmp/pip-qdSuFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:28:57 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)) 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:28:57 INFO - Running setup.py (path:/tmp/pip-NxAAzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:28:57 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)) 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:57 INFO - Running setup.py (path:/tmp/pip-1okiaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:57 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)) 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:28:57 INFO - Running setup.py (path:/tmp/pip-47Uano-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:28:57 INFO - Running setup.py (path:/tmp/pip-MnXq3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:28:57 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)) 09:28:57 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)) 09:28:57 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)) 09:28:57 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)) 09:28:57 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)) 09:28:57 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)) 09:28:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:28:57 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 09:28:57 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 09:28:57 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 09:28:57 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 09:28:57 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 09:28:57 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 09:28:59 INFO - Downloading blessings-1.6.tar.gz 09:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:28:59 INFO - Installing collected packages: blessings 09:28:59 INFO - Running setup.py install for blessings 09:28:59 INFO - Successfully installed blessings 09:28:59 INFO - Cleaning up... 09:28:59 INFO - Return code: 0 09:28:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:00 INFO - Reading from file tmpfile_stdout 09:29:00 INFO - Current package versions: 09:29:00 INFO - argparse == 1.2.1 09:29:00 INFO - blessings == 1.6 09:29:00 INFO - blobuploader == 1.2.4 09:29:00 INFO - docopt == 0.6.1 09:29:00 INFO - functools32 == 3.2.3-2 09:29:00 INFO - jsonschema == 2.5.1 09:29:00 INFO - manifestparser == 1.1 09:29:00 INFO - mozInstall == 1.12 09:29:00 INFO - mozcrash == 1.0 09:29:00 INFO - mozdebug == 0.1 09:29:00 INFO - mozdevice == 0.49 09:29:00 INFO - mozfile == 1.2 09:29:00 INFO - mozhttpd == 0.7 09:29:00 INFO - mozinfo == 0.9 09:29:00 INFO - mozleak == 0.1 09:29:00 INFO - mozlog == 3.4 09:29:00 INFO - moznetwork == 0.27 09:29:00 INFO - mozprocess == 0.24 09:29:00 INFO - mozprofile == 0.28 09:29:00 INFO - mozrunner == 6.13 09:29:00 INFO - mozscreenshot == 0.1 09:29:00 INFO - mozsystemmonitor == 0.3 09:29:00 INFO - moztest == 0.8 09:29:00 INFO - mozversion == 1.4 09:29:00 INFO - psutil == 3.1.1 09:29:00 INFO - requests == 1.2.3 09:29:00 INFO - wsgiref == 0.1.2 09:29:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:00 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 0x19e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, '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': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', '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 09:29:00 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 09:29:00 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 09:29:00 INFO - Using env: {'DISPLAY': ':0', 09:29:00 INFO - 'HOME': '/home/cltbld', 09:29:00 INFO - 'LANG': 'en_US.UTF-8', 09:29:00 INFO - 'LANGUAGE': 'en_US:en', 09:29:00 INFO - 'LOGNAME': 'cltbld', 09:29:00 INFO - 'MAIL': '/var/mail/cltbld', 09:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:00 INFO - 'MOZ_NO_REMOTE': '1', 09:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:00 INFO - 'NO_EM_RESTART': '1', 09:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:00 INFO - 'PWD': '/builds/slave/test', 09:29:00 INFO - 'SHELL': '/bin/bash', 09:29:00 INFO - 'SHLVL': '1', 09:29:00 INFO - 'TERM': 'linux', 09:29:00 INFO - 'TMOUT': '86400', 09:29:00 INFO - 'USER': 'cltbld', 09:29:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:00 INFO - '_': '/tools/buildbot/bin/python'} 09:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:00 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)) 09:29:00 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)) 09:29:00 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)) 09:29:00 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)) 09:29:00 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)) 09:29:00 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)) 09:29:00 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)) 09:29:00 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)) 09:29:00 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)) 09:29:00 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)) 09:29:00 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)) 09:29:00 INFO - Cleaning up... 09:29:00 INFO - Return code: 0 09:29:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:00 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 0x19e91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, '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': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', '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 09:29:00 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 09:29:00 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 09:29:00 INFO - Using env: {'DISPLAY': ':0', 09:29:00 INFO - 'HOME': '/home/cltbld', 09:29:00 INFO - 'LANG': 'en_US.UTF-8', 09:29:00 INFO - 'LANGUAGE': 'en_US:en', 09:29:00 INFO - 'LOGNAME': 'cltbld', 09:29:00 INFO - 'MAIL': '/var/mail/cltbld', 09:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:00 INFO - 'MOZ_NO_REMOTE': '1', 09:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:00 INFO - 'NO_EM_RESTART': '1', 09:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:00 INFO - 'PWD': '/builds/slave/test', 09:29:00 INFO - 'SHELL': '/bin/bash', 09:29:00 INFO - 'SHLVL': '1', 09:29:00 INFO - 'TERM': 'linux', 09:29:00 INFO - 'TMOUT': '86400', 09:29:00 INFO - 'USER': 'cltbld', 09:29:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:00 INFO - '_': '/tools/buildbot/bin/python'} 09:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:29:00 INFO - Cleaning up... 09:29:00 INFO - Return code: 0 09:29:00 INFO - Running post-action listener: _resource_record_post_action 09:29:00 INFO - Running post-action listener: _start_resource_monitoring 09:29:00 INFO - Starting resource monitoring. 09:29:00 INFO - [mozharness: 2017-01-11 17:29:00.563059Z] Finished create-virtualenv step (success) 09:29:00 INFO - [mozharness: 2017-01-11 17:29:00.563562Z] Running install step. 09:29:00 INFO - Running pre-action listener: _resource_record_pre_action 09:29:00 INFO - Running main action method: install 09:29:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:00 INFO - Reading from file tmpfile_stdout 09:29:00 INFO - Detecting whether we're running mozinstall >=1.0... 09:29:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:29:00 INFO - Reading from file tmpfile_stdout 09:29:00 INFO - Output received: 09:29:00 INFO - Usage: mozinstall [options] installer 09:29:00 INFO - Options: 09:29:00 INFO - -h, --help show this help message and exit 09:29:00 INFO - -d DEST, --destination=DEST 09:29:00 INFO - Directory to install application into. [default: 09:29:00 INFO - "/builds/slave/test"] 09:29:00 INFO - --app=APP Application being installed. [default: firefox] 09:29:00 INFO - mkdir: /builds/slave/test/build/application 09:29: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'] 09:29: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 09:29:18 INFO - Reading from file tmpfile_stdout 09:29:18 INFO - Output received: 09:29:18 INFO - /builds/slave/test/build/application/firefox/firefox 09:29:18 INFO - Running post-action listener: _resource_record_post_action 09:29:18 INFO - [mozharness: 2017-01-11 17:29:18.294100Z] Finished install step (success) 09:29:18 INFO - [mozharness: 2017-01-11 17:29:18.294371Z] Running run-tests step. 09:29:18 INFO - Running pre-action listener: _resource_record_pre_action 09:29:18 INFO - Running main action method: run_tests 09:29:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:29:18 INFO - Python 2.7.3 09:29:18 INFO - Return code: 0 09:29:18 INFO - grabbing minidump binary from tooltool 09:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:18 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 0x1de4850>, '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 0x1d596d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d59b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:29:18 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 09:29:18 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 09:29:18 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 09:29:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:29:18 INFO - Return code: 0 09:29:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:29:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:29:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:29:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:29:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:29:18 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/1484145356/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:29:18 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/1484145356/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 09:29:18 INFO - Using env: {'DISPLAY': ':0', 09:29:18 INFO - 'HOME': '/home/cltbld', 09:29:18 INFO - 'LANG': 'en_US.UTF-8', 09:29:18 INFO - 'LANGUAGE': 'en_US:en', 09:29:18 INFO - 'LOGNAME': 'cltbld', 09:29:18 INFO - 'MAIL': '/var/mail/cltbld', 09:29:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:29:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:18 INFO - 'MOZ_NO_REMOTE': '1', 09:29:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:18 INFO - 'NO_EM_RESTART': '1', 09:29:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:18 INFO - 'PWD': '/builds/slave/test', 09:29:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:29:18 INFO - 'SHELL': '/bin/bash', 09:29:18 INFO - 'SHLVL': '1', 09:29:18 INFO - 'TERM': 'linux', 09:29:18 INFO - 'TMOUT': '86400', 09:29:18 INFO - 'USER': 'cltbld', 09:29:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565', 09:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:18 INFO - '_': '/tools/buildbot/bin/python'} 09:29:18 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/1484145356/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:29:18 INFO - mozversion application_buildid: 20170111063556 09:29:18 INFO - mozversion application_changeset: c98510adc780b5d67acc1bbf79568e2abc03450b 09:29:18 INFO - mozversion application_display_name: Nightly 09:29:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:29:18 INFO - mozversion application_name: Firefox 09:29:18 INFO - mozversion application_remotingname: firefox 09:29:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:29:18 INFO - mozversion application_vendor: Mozilla 09:29:18 INFO - mozversion application_version: 53.0a1 09:29:18 INFO - mozversion platform_buildid: 20170111063556 09:29:18 INFO - mozversion platform_changeset: c98510adc780b5d67acc1bbf79568e2abc03450b 09:29:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:29:18 INFO - mozversion platform_version: 53.0a1 09:29:18 INFO - using testdate: 1484155758 09:29:18 INFO - actual date: 1484155758 09:29:18 INFO - starting webserver on 'localhost:50062' 09:29:18 INFO - SUITE-START | Running 2 tests 09:29:18 INFO - TEST-START | dromaeo_css 09:29:18 INFO - operating with platform_type : linux_ 09:29:18 INFO - Initialising browser for dromaeo_css test... 09:29:18 INFO - TEST-INFO | started process 17238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp13hbRb/profile http://localhost:50062/getInfo.html) 09:29:21 INFO - PROCESS | 17238 | __metrics Screen width/height:1600/1200 09:29:21 INFO - PROCESS | 17238 | colorDepth:24 09:29:21 INFO - PROCESS | 17238 | Browser inner width/height: 1024/697 09:29:21 INFO - PROCESS | 17238 | __metrics 09:29:22 INFO - PROCESS | 17238 | 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" 09:29:22 INFO - PROCESS | 17238 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:29:23 INFO - PROCESS | 17238 | console.error: PushService: 09:29:23 INFO - PROCESS | 17238 | stateChangeProcessEnqueue: Error transitioning state 09:29:23 INFO - PROCESS | 17238 | UnknownError 09:29:23 INFO - TEST-INFO | 17238: exit 0 09:29:23 INFO - Browser initialized. 09:29:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:29:23 INFO - TEST-INFO | started process 17324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp13hbRb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:35 INFO - PROCESS | 17324 | RSS: Main: 147742720 09:29:35 INFO - PROCESS | 17324 | 09:32:37 INFO - PROCESS | 17324 | Cycle 1(1): loaded http://localhost:50062/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50062/tests/dromaeo/cssquery-ext.html) 09:32:38 INFO - PROCESS | 17324 | RSS: Main: 247812096 09:32:38 INFO - PROCESS | 17324 | 09:34:24 INFO - PROCESS | 17324 | ************************* 09:34:24 INFO - PROCESS | 17324 | A coding exception was thrown and uncaught in a Task. 09:34:24 INFO - PROCESS | 17324 | 09:34:24 INFO - PROCESS | 17324 | Full message: ReferenceError: fetch is not defined 09:34:24 INFO - PROCESS | 17324 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 09:34:24 INFO - PROCESS | 17324 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 09:34:24 INFO - PROCESS | 17324 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 09:34:24 INFO - PROCESS | 17324 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 09:34:24 INFO - PROCESS | 17324 | TaskImpl@resource://gre/modules/Task.jsm:277:3 09:34:24 INFO - PROCESS | 17324 | asyncFunction@resource://gre/modules/Task.jsm:252:14 09:34:24 INFO - PROCESS | 17324 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 09:34:24 INFO - PROCESS | 17324 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 09:34:24 INFO - PROCESS | 17324 | TaskImpl@resource://gre/modules/Task.jsm:277:3 09:34:24 INFO - PROCESS | 17324 | asyncFunction@resource://gre/modules/Task.jsm:252:14 09:34:24 INFO - PROCESS | 17324 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 09:34:24 INFO - PROCESS | 17324 | 09:34:24 INFO - PROCESS | 17324 | ************************* 09:35:40 INFO - PROCESS | 17324 | Cycle 1(1): loaded http://localhost:50062/tests/dromaeo/cssquery-ext.html (next: http://localhost:50062/tests/dromaeo/cssquery-jquery.html) 09:35:41 INFO - PROCESS | 17324 | RSS: Main: 240865280 09:35:41 INFO - PROCESS | 17324 | 09:38:43 INFO - PROCESS | 17324 | Cycle 1(1): loaded http://localhost:50062/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50062/tests/dromaeo/cssquery-mootools.html) 09:38:44 INFO - PROCESS | 17324 | RSS: Main: 179904512 09:38:44 INFO - PROCESS | 17324 | 09:41:46 INFO - PROCESS | 17324 | Cycle 1(1): loaded http://localhost:50062/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50062/tests/dromaeo/cssquery-prototype.html) 09:41:46 INFO - PROCESS | 17324 | RSS: Main: 223436800 09:41:46 INFO - PROCESS | 17324 | 09:44:49 INFO - PROCESS | 17324 | Cycle 1(1): loaded http://localhost:50062/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50062/tests/dromaeo/cssquery-yui.html) 09:44:50 INFO - PROCESS | 17324 | RSS: Main: 181518336 09:44:50 INFO - PROCESS | 17324 | 09:47:52 INFO - PROCESS | 17324 | Cycle 1(1): loaded http://localhost:50062/tests/dromaeo/cssquery-yui.html (next: http://localhost:50062/tests/dromaeo/cssquery-dojo.html) 09:47:52 INFO - PROCESS | 17324 | RSS: Main: 277385216 09:47:52 INFO - PROCESS | 17324 | 09:47:52 INFO - PROCESS | 17324 | __start_tp_report 09:47:52 INFO - PROCESS | 17324 | _x_x_mozilla_page_load 09:47:52 INFO - PROCESS | 17324 | _x_x_mozilla_page_load_details 09:47:52 INFO - PROCESS | 17324 | |i|pagename|runs| 09:47:52 INFO - PROCESS | 17324 | |0;dojo.html;3140.9057728268153;3170.073389643629;3200.327931134462;3204.7275981541566;3207.102011436797;5363.9463605363935;5407.3781515125775;5431.701256430894;5466.1527463243165;5498.202760599711;5462.262594549735;5517.393086760463;5542.61201715879;5559.610827242094;5577.163425486169;4981.053599816041;5006.424261209971;5010.749462526877;5044.545990860822;5072.213806859924;5091.414487333948;5172.353455818023;5195.6622819516615;5196.220566914974;5223.582113430916;4930.211166213388;4954.232094025432;5049.065922804293;5073.873153171164;5111.207762796773;4962.553370196663;4974.502549745032;4997.400311962588;5000.699958002495;5078.568321692661;4950.43070046942;4966.50334966504;4968.925466118011;4971.428285747149;5022.045811295842;5433.429489903543;5522;5542.4457554244655;5546.77812887484;5558.833235002957;5847.795327163529;5898.203742494751;5944.4352786485215;5952.851178720567;6032.487238584726;5979.372165922559;5994.7901823436405;6000.519958403317;6007.189029481008;6012.278526576795;5567.916481252784;5570.972145139248;5574.080276754331;5577.27495425592;5580.162975553659;5881.206037185011;5899.587028908021;5948.67282299469;6019.909701354483;6034.607750496204;5738.024535828919;5772.307323121252;5774.711264436762;5781.768729250867;5787.131930210502;5847.795327163529;5858.912116318259;5859.20900678403;5868.413158684183;5978.192943952511;5790.768369265266;5819.068948968229;5842;5866;5883.14694369314;5935.643861368331;5939.109133629903;5945.583809133405;5967.104934259895;5985.132155837467;4608.5621865922685;4614.792334344963;4615.446146462446;4620.099080679235;4655.3249778782565;4025.496812898388;4029.2143032108456;4035.5157381114454;4055.858044968412;4077.8368865245056;5572.164175373645;5580.804671836548;5580.888382232332;5612.887742245214;5626.578006649518;5953.077273022688;5955.76176952917;5957.195778569924;5958.463738263577;5961.850953726192;5432.483914028161;5476.561875049986;5518.53092487135;5579.0515612346;5583.609147359646;5063.696178229318;5091.669041512364;5102.744862756847;5124.410692770379;5150.536451719363;6137.110119032715;6180.351063138396;6190.41191086846;6191.566590338633;6191.84520386994;5680.062789639664;5738;5931.258592675916;5984.730687119177;5995.640261584319;6084.39156084388;6125.173101631222;6133.754649813957;6161.44546990773;6161.537884658758;5843.152742852178;5845.386234445322;5847.947369473365;5865.384134665798;5922.674252916131;5740.6268592541355;5936.436038576328;5938.435848594377;5939.673317967553;5939.792107276225;5588.748506317144;5737.311522617312;5739.225204597493;5793.188953546422;5883.323417807007;5775.133729940542;5834.679092649945;5835.183074369676;5836.358000619844;5844.444777746107;5666.546676265806;5710.8001219957105;5835.79574714883;5839.153322768259;5841.18223448726;5818.796342128006;5855.765769369177;5886.58793884424;5892.941070589411;5985.132155837467;5752.33848107473;5781.739821708117;5783.3638299787835;5785.218995435563;5786.826395208151 09:47:52 INFO - PROCESS | 17324 | |1;ext.html;544.6582316388411;583.778164297567;600.5885968111843;618.7494064903713;713.7359177104472;33638.49542256868;43828.3425748614;44168.999999999956;44294.77852610732;49036.264456033095;45720.771396142976;46080.308795368095;46206.30690539644;46268.76118671694;46298.537014629845;8711.782205444882;8807.119288071206;8954.104589541043;9129.315301352392;9144.131307525808;10729.08802751767;10966.06788422985;10970.341779493216;11362.886371136265;11366.829497557543;11039.39283339416;11140.777184456307;11147.108231341514;11147.832782508269;11149.052330551913;11156;11157.27477713946;11172;11203.551857925673;11218.102551795837;10801.67594972152;10890.782184356347;10892.61875834342;10893.891061089445;10895.128389728803;43839.56160438387;44116.55883441157;44167.33748993768;44195.77902110501;44225.55774442247;4201.096764195712;4238.237117318881;4294.914101717948;4344.565543445662;4387;32595.18512037194;32787.18032049194;32991.50512742311;33273.833630831934;34936.475952860725;3683.631636836322;3741.1021354874633;3763.303788799081;3767.7174211934216;3796.7152463565344;346920;347561;347706;348533;348553;62123.689381553704;62313.376866231665;62562;63031.369686303464;63088;65636;65911;65913.34086659168;65949.67025164844;65970.46561153462;16188.75716864248;16680.49958501247;16699.08155051484;16709.415170468976;16717.916410418115;11309.547618095348;11562.653120406401;11597.304161750322;11726.824097638542;12872;16095.678086438205;16620.501384958472;17862.642747144986;18214.726779098324;18229.7265541017;6380.617162970237;6413.743450262031;6429.357064293533;6442.486015786287;6452.548321617535;940.8823897012874;942.599395257013;944.5135755086136;949.886013678363;966.1739212972948;30662.54006189909;32220.516692249636;32539;32903.81800590467;32981.835090824876;1051.9105876000626;1054.947252637365;1068.6374872038214;1069.4652673663168;1078.2129045796455;14638.780418293734;15401.383944642314;15428.460003899809;15480.458183963507;15679.843201567839;473107;473191;476276;476812;478060;55388.44611553913;55692.72153639206;55720.44279557234;55722.16416753752;55800.44199558034;1430.8139941807706;1445.645816774897;1465.1282486920265;1466.4793998130724;1469.6252455623749;26942.59586106171;27677.33170098017;27832.721672783013;28425.715742843135;28789.56815647809;46001;46273.3059004122;46392.30411543897;46466.76766616145;46521.302180467996;393756;394528;395592;395689;395763;25157.371065723502;25462.74537254678;25526.489470210865;26448.338791529597;26981.865090674422;39624;43108.78445607752;43136.35295470508;43212.567874320855;43405;36969.44545831868;37201.25597488089;37414.8129259352;37499.250014999;37998.43002354912;35868;37069.44395834119;37133.62866371302;37646.2470750578;38259.80870095743;36560;36572.81713591521;36768;36821;37373.81313093417;31287.374252515277;32979.34041319208;33366.16584585308;33614.49578256377;33785.49321760225;25046.248612541654;25391;25501.744982550677;25579.36051598725;25936.870315648302 09:47:52 INFO - PROCESS | 17324 | |2;jquery.html;412.6678024190525;417.44062955639447;423.4960397127416;426.32001956878776;449.8223201835275;19005.334813281537;20526.38420847375;20886.37340879772;21475.46311342217;21728;21256.29949604032;21747.891260543714;21902.89048554759;21938.89030554849;22199.889000554973;5698.0626586960425;5936.821895343125;5958.344582095966;5958.821235362924;6105;3953.7034722395792;4130.8141133648905;4132.5040995080635;4167.374893765929;5323.148296272597;4113.8971525711795;4115.444415003981;4179.226843034034;4183.3515805050265;4184.811683474251;4120.990357362435;4168.24971505129;4170.124273902469;4953.182724850395;5726.484616384504;5179.689218646893;5191.273221748958;5193.246979187997;5194.974025129888;5195.116830138885;24918.626220606704;25146.11988580391;25291.367715807068;25419.61870571943;25837.224883253533;2676;3018.44158830617;3182.220356012792;3220.339830334799;3246.4967929970894;10605.628802991858;10767;10913.345199288067;10928.289661171999;11232.66302010941;1939.6120775844888;1958.9314373996983;1968.803119688034;1987.6124155789628;1994.6409646263667;92235;94379;94712.52643736805;95241.52379238128;95977;11862.288262704093;11895;11913.583024594098;11982.382378378981;12162.08784341178;17135.74296385555;17161.828381716274;17173.055481948613;17178.91410542964;17189.656206875792;8411.579421028924;8722.912770872337;8739.737807865775;8759.693410730593;8820.955895220612;8042.437029407885;8053.758387248392;8322.916770832215;8339.666413343519;8346.8330633387;5037.773300201499;5064.924026139611;5070.467600901852;5152.613553983391;5287.154055351202;1992.85053620979;2073.782252863458;2106.2083759447073;2139.9037043333087;2148.1407437025314;878.9516576588348;895.8566629339274;899.9550022498848;901.2429559170329;904.7738065483629;19636.509087272647;20605.587888242153;20933.162673493196;21019.474513137295;21038.89480552618;895.8297923394534;905.063259526387;907.577976241051;907.6369452219166;920.3235621817959;10808.243422960317;11504.309741415542;11540.192186546861;11562.30626162433;11593.072554195644;605997;622424;631682;646516;646964;68279;95190.5240473807;101911;103107.08054412558;105419;1029.7528593137592;1044.4151275285865;1080.3247970018738;1081.0270756319376;1085.755704966392;17138.828611713725;18491.72262416038;18661.253549857855;18746.812531874508;19099;47748.761256193495;48145.27782083341;48808.267875981175;48970;49165.508344916096;61317;61715.38284617096;62893;63139;66033;6010.398960103955;7946.841063178819;8192.139825318494;8894.28845692356;9401.059894010545;10162.339447935861;13425.328733563478;13826.170429774245;13901.374438150106;14273.717884634361;7711.922880771121;12241.449134788778;12280;12628;12954.417051232529;12307.507699691912;12464.252144871336;12656.74686506283;12728.363581821057;13009.934950325567;11608.477618507357;12474.625761227178;12715.745685086431;12844;13208.669783255495;9087.36388452802;9185.311101667268;9323.347365684336;9324.720258391988;9333.160015598629;9443.291753118681;12083.57707480234;12527.244006318595;12554.623361299176;12569.497220111092 09:47:52 INFO - PROCESS | 17324 | |3;mootools.html;1433.5197708767562;1442.884569234461;1444.826620805503;1445.768677011677;1456.1627064437948;8096.514209147448;8488.61801218945;8545.401821872472;8550.871736923935;8551.914480855197;7370.668319925603;7607.467477276579;7951.840963180733;8211.589420528979;8370.037445693748;2315.1896836107353;2351.0595761695286;2352.329586067971;2355.9764402356013;2361.551305252005;2333.148400833692;2361.0791791201445;2362.244081893795;2369.052379048377;2381.3570336009266;2002.2591641092815;2071.440711008027;2270.897809598564;2326.7905888470036;2338.9064437422485;2243.7756224377595;2260.242818655752;2261.2424837679396;2261.9095236190533;2266.9433264168365;2206.481476852938;2245.348848833836;2291.0950174680906;2292.713410823647;2297.287840769367;8336.166383361615;8391.909051823284;8399.160083991552;8401.201885820898;8401.621927013299;5227.895442091137;5340.946590534084;5350.5987050971335;5351.384590772033;5364.168553874156;3142.1359126240236;3261.8205998670064;3277.147941535194;3293.6870997255223;3300.3069355435387;1271.8600953895063;1340.7988801679826;1353.343628340254;1392.2133994293192;1415.469199050356;11435.542578296858;11490.253133546375;11503.654890353302;11533.653990380302;11542.769144617061;4568.360429539867;4744.928826067612;4808.326834243208;4808.735519546389;4933.50664933511;10187.847182292271;10211.081002709792;10211.540480678239;10218.080372766486;10234.334768240189;5445.292112025411;5446.618736688473;5447.754851031713;5452.563794896399;5456.045192091368;4303.849365272201;4438.489573699066;4881.145799485076;4882.438519570223;4917.680350777188;3898.863539776094;3966.2860685076384;4030.7380020298588;4065.8780236592947;4069.674426045909;1243.3348158735034;1271.313490715022;1272.5228039485194;1290.9741805164033;1292.6509842342514;977.0913050862624;981.4601968917067;986.3687240166299;992.6029588164791;1010.4846528270635;5521.033819081645;5646.85882852932;5734.111212762028;5771.278590176228;5887.322957859816;625.5746092657037;628.6793735194992;630.146151964082;631.8262477818545;641.3682522715216;3700.50043244164;3716.832742526593;3783.810809459516;3789.317922773927;4072.857449989236;10401.167906567456;10630.362178269328;10644.308119972176;10671.57313707443;10681;10489.737756555995;10498.265121441425;10507.94746026265;10522.684319470429;10525.42110183932;7308.853822923512;7580.507267027626;7624.504407213624;7640.656170472342;7720.3051725344985;5466.34403871522;5508.55931525469;5570.136628822539;5657.349404818498;5722.055860782924;9314;9321.533923303943;9338.859917101114;9362.859557106513;9434.198093161884;9549.52252387364;9559.952200238955;9636.855447168158;9665.130138287588;9675.516224188621;6832.795016149524;7034.050403195503;7039.718411263492;7494.925050749423;7610.505317154367;7622.58075805836;8051.557164356017;8107.71622993216;8155.429119961783;8194.38542109356;7303.598302093435;7328.78013659591;7442.96278518604;7559.811004724926;7561.508501947355;7120.252373500708;7238.167610724834;7278.272172782679;7387.889181662387;7453.590052547162;6216.937830621636;6284.183056202847;6285.277193122849;6286.591371560834;6287.2769631492965;4813.78337974799;4884.12085824555;4895.461499235153;4932.654714169974;4957.330760347451;5092.0579692756955;5273.288106105627;5294.814681486284;5320.255164277081;5372.704501252469 09:47:52 INFO - PROCESS | 17324 | |4;prototype.html;392.2586311870565;404.1694318176148;407.5170922456889;409.1673444540361;413.1468517511339;5402.621816472843;5405.48646379014;5408.323959505066;5408.621396502246;5436.592255580837;5213.244079608455;5246.842594722155;5281.735913204334;5303.443138470463;5379.81170659027;4322.84870029549;4330.913381732364;4347.174036932988;4352.673549483786;4373.781310934456;4281.850135245267;4287.721298115628;4306.547812479692;4362.345648152771;4363.4327537420095;3992.580779018205;4006.979965100185;4249.8950272929105;4260.8721738347895;4303.634191093761;4269.6370808481315;4277.123189746095;4278.1871444425615;4291.163223171483;4301.935470967954;3858.7298889077774;3868.613138686137;3876.341022026262;3880.4373365862075;3901.3809269153267;5074.847754567369;5157.6647517911215;5211.557017653504;5223.6343455958095;5231.712255825928;4917.901641967176;4928.753562321869;4940.382452193476;4960.70235785854;4977.068116188207;5587.38538760736;5632.46491583303;5637.46444087811;5651.2935883014625;5690.459406356431;3851.1912498375373;3988.481497405348;4018.9397159042637;4269.615734583902;4287.871363859089;5737.39757325479;5779.826605201851;5783.797567085132;5788.797392091299;5814.447627475383;4139.317012692872;4160.979195104005;4161.169085602325;4186.874393768192;4188.623023927861;4121.567235440296;4149;4163.458750362433;4258.1057977825;4261.2542805009;4741.525847415231;4742.644301677319;4749.4063242094735;4758.3100450434495;4784.330193772875;5545.528630066409;5598.3282006159525;5645.5483561314995;5647.37878833328;5653.088659340443;1349.8987575931844;1391.631217727303;1395.1350162899068;1399.0626280392162;1400.775875859878;929.9395539289925;948.2319321349729;956.9425834449955;985.3347842146749;992.9007099290013;5202.2196670499725;5226.778619086873;5266.867623460974;5308.495692909168;5324.946750532523;5570.610057296031;5636.605437619327;5643.125315576092;5647.915281270784;5658.603897727202;5080.23796430531;5090.872728181825;5177;5215.947840521546;5275.525202731773;2945.572891930658;2957.5267957126757;2972.8810847566288;2978.4340975215073;2993.5509673548704;5579.609427340129;5667.489925906688;5713.228714123623;5733.627314224562;5742.368339482654;5664.68844213564;5666.631668941505;5672.517835983905;5678.205051292823;5702.942970570324;5704.22992895962;5746.712664366765;5759.452851979056;5800.4199580042505;5808.186853840551;5444.223446042468;5511.53151982086;5580.330360356783;5590.596043701247;5649.209110724584;5526.839363733661;5534.308211473566;5540.033288182798;5544.805931792368;5550.335838797319;5462.945370546244;5673.744681489426;5730.484256416776;5776.036147709799;5802.506786923159;4009.2983727848095;4019.738716983387;4025.8188381523487;4031.8106158683845;4062.309407400808;5565.471280228372;5572.96586745843;5581.804636837691;5635.295588051494;5670.886582268414;5272;5396.140045775745;5410.78356865721;5484.561235101102;5499.1476321170285;5405.837824865261;5435.266239057677;5463.863403414946;5469.9179512306555;5486.890262194814;5398.2442458056685;5410.404855465974;5413.864653383697;5472.589555783253;5541.556675466034;5532.253145825262;5603.719814009365;5606.775728970795;5655.462731040545;5661.377248502579;5485.835424937259;5501.63429725222;5517.69652669107;5531.391546929754;5534.181414823759 09:47:52 INFO - PROCESS | 17324 | |5;yui.html;729.5877829026603;741.347614099593;769.5844244108182;770.7764748223016;788.8974433323668;18303.908480457594;18588.16353264103;18658.533536661573;18735.25058997642;19860.106295216712;16600.25298861551;18418.815811841876;18446.723299150523;18451;18494.537636559093;723.9420846332281;752.5672738175543;758.7951253161643;758.9886151707728;759.7948553890474;762.9694812207505;766.7469734987441;767.0182166826443;767.0833354141803;767.2557619109483;796.8167321516055;797.9082405523382;798.9640466179006;799.0970203669845;799.7041094794905;791.2799352589174;793.996030019852;794.8450052239787;795.1094773853292;795.4988357334871;578.4504720515486;578.8639669677623;579.3192998227066;579.4379451931619;579.7304253522133;16693.081880496567;16736.16319184036;16751.07869067201;17434.91282543592;17660.205290761947;14307.141571505743;14460.421583136767;14580.927095364455;14804.40782368704;14870.851291487055;11333.489992950337;11337.37644429556;11447.828282575769;11500.367479788609;11545.595904143314;3688.4467329900463;3726.9440958385644;3786.8863934081746;3805.429185622179;3816.484774555427;56541.71729141328;60740.69629651823;63048.36951630517;71377.28622713758;81074.59462702648;11232.55069797199;11591.478383472764;11636.650900473;11674.649760507198;11758.88241117595;22847.428814279443;22897.313080607277;22941.655875161887;23098.07607695707;23150.65274020891;8048.154943730941;8107.391945603986;8167.959160204161;8173.836523269501;8307.376946728898;4330.307150855911;4347.934780978288;4416.205083085076;4492.932606010847;4574.634029277717;3469.774464659789;3515.367233897923;3525.294941011808;3559.875404360887;3569.3396721606587;610.0513701194596;615.2649528330066;618.9195404597464;620.981370558884;625.0499241153422;731.7438896386328;744.7840126363402;747.484235877243;758.2531206761336;784.3568274015366;10251.231157663056;10602.840957385646;10740.570377184982;10903.400312982703;11203.103751699844;733.3399940053994;739.2053542441896;763.2634507700096;763.7823220382276;773.3697036914897;4828.130936431476;5007.599392048627;5120.667156634807;5121.923171152435;5125.718085505333;76621;79920.60039699764;80367.59816200999;84228.15771842326;84833.57583212169;69842;71493.642531787;71599.64200178966;71879.28120718726;73199.63400182965;60053.399466005656;61123;61444.69277653672;61802.69098654568;64683.353166468674;9243.168114869424;9272.119148680864;9394.859077113986;9414.95292523533;9442;36309.45535817018;36647.81676091602;37236.627633723314;38000.80999594984;46631.766841165576;55275.17087243614;56136;57027.714861425426;57383;57514.424855750905;13144.60566183016;13157.407916643582;13199.472021119047;13319.200847949154;13532.255725935169;14353;14356.784648230494;15075.773863391838;15104.320305586494;15634.27548661365;13637.590872273848;13676.247806370746;13972;14251.57245282643;14638.121712697272;12620.621381358575;12736.808947865975;12897.484100636244;13091.869081309445;13149.802752958522;13435.12671676338;13519.986001050158;13551.569149994237;13697.589072327846;13730.244836533688;11308.83036754433;11359.54561817518;11675.941620292184;11807.817184680089;11888.76222475563;10803.675889723321;10815.35107893529;10826.350418974887;10895.782084358427;10902.781944361226 09:47:52 INFO - PROCESS | 17324 | __end_tp_report 09:47:52 INFO - PROCESS | 17324 | __start_cc_report 09:47:52 INFO - PROCESS | 17324 | _x_x_mozilla_cycle_collect,1317 09:47:52 INFO - PROCESS | 17324 | __end_cc_report 09:47:52 INFO - PROCESS | 17324 | __startTimestamp1484156872835__endTimestamp 09:47:52 INFO - PROCESS | 17324 | 09:47:52 INFO - PROCESS | 17324 | ------- Summary: start ------- 09:47:52 INFO - PROCESS | 17324 | Number of tests: 6 09:47:52 INFO - PROCESS | 17324 | 09:47:52 INFO - PROCESS | 17324 | [#0] dojo.html Cycles:165 Average:5502.67 Median:5739.23 stddev:623.25 (10.9%) stddev-sans-first:596.98 09:47:52 INFO - PROCESS | 17324 | Values: 3140.9 3170.1 3200.3 3204.7 3207.1 5363.9 5407.4 5431.7 5466.2 5498.2 5462.3 5517.4 5542.6 5559.6 5577.2 4981.1 5006.4 5010.7 5044.5 5072.2 5091.4 5172.4 5195.7 5196.2 5223.6 4930.2 4954.2 5049.1 5073.9 5111.2 4962.6 4974.5 4997.4 5000.7 5078.6 4950.4 4966.5 4968.9 4971.4 5022.0 5433.4 5522.0 5542.4 5546.8 5558.8 5847.8 5898.2 5944.4 5952.9 6032.5 5979.4 5994.8 6000.5 6007.2 6012.3 5567.9 5571.0 5574.1 5577.3 5580.2 5881.2 5899.6 5948.7 6019.9 6034.6 5738.0 5772.3 5774.7 5781.8 5787.1 5847.8 5858.9 5859.2 5868.4 5978.2 5790.8 5819.1 5842.0 5866.0 5883.1 5935.6 5939.1 5945.6 5967.1 5985.1 4608.6 4614.8 4615.4 4620.1 4655.3 4025.5 4029.2 4035.5 4055.9 4077.8 5572.2 5580.8 5580.9 5612.9 5626.6 5953.1 5955.8 5957.2 5958.5 5961.9 5432.5 5476.6 5518.5 5579.1 5583.6 5063.7 5091.7 5102.7 5124.4 5150.5 6137.1 6180.4 6190.4 6191.6 6191.8 5680.1 5738.0 5931.3 5984.7 5995.6 6084.4 6125.2 6133.8 6161.4 6161.5 5843.2 5845.4 5847.9 5865.4 5922.7 5740.6 5936.4 5938.4 5939.7 5939.8 5588.7 5737.3 5739.2 5793.2 5883.3 5775.1 5834.7 5835.2 5836.4 5844.4 5666.5 5710.8 5835.8 5839.2 5841.2 5818.8 5855.8 5886.6 5892.9 5985.1 5752.3 5781.7 5783.4 5785.2 5786.8 09:47:52 INFO - PROCESS | 17324 | 09:47:52 INFO - PROCESS | 17324 | [#1] ext.html Cycles:180 Average:56857.69 Median:20252.32 stddev:108203.01 (534.3%) stddev-sans-first:108423.94 09:47:52 INFO - PROCESS | 17324 | Values: 544.7 583.8 600.6 618.7 713.7 33638.5 43828.3 44169.0 44294.8 49036.3 45720.8 46080.3 46206.3 46268.8 46298.5 8711.8 8807.1 8954.1 9129.3 9144.1 10729.1 10966.1 10970.3 11362.9 11366.8 11039.4 11140.8 11147.1 11147.8 11149.1 11156.0 11157.3 11172.0 11203.6 11218.1 10801.7 10890.8 10892.6 10893.9 10895.1 43839.6 44116.6 44167.3 44195.8 44225.6 4201.1 4238.2 4294.9 4344.6 4387.0 32595.2 32787.2 32991.5 33273.8 34936.5 3683.6 3741.1 3763.3 3767.7 3796.7 346920.0 347561.0 347706.0 348533.0 348553.0 62123.7 62313.4 62562.0 63031.4 63088.0 65636.0 65911.0 65913.3 65949.7 65970.5 16188.8 16680.5 16699.1 16709.4 16717.9 11309.5 11562.7 11597.3 11726.8 12872.0 16095.7 16620.5 17862.6 18214.7 18229.7 6380.6 6413.7 6429.4 6442.5 6452.5 940.9 942.6 944.5 949.9 966.2 30662.5 32220.5 32539.0 32903.8 32981.8 1051.9 1054.9 1068.6 1069.5 1078.2 14638.8 15401.4 15428.5 15480.5 15679.8 473107.0 473191.0 476276.0 476812.0 478060.0 55388.4 55692.7 55720.4 55722.2 55800.4 1430.8 1445.6 1465.1 1466.5 1469.6 26942.6 27677.3 27832.7 28425.7 28789.6 46001.0 46273.3 46392.3 46466.8 46521.3 393756.0 394528.0 395592.0 395689.0 395763.0 25157.4 25462.7 25526.5 26448.3 26981.9 39624.0 43108.8 43136.4 43212.6 43405.0 36969.4 37201.3 37414.8 37499.3 37998.4 35868.0 37069.4 37133.6 37646.2 38259.8 36560.0 36572.8 36768.0 36821.0 37373.8 31287.4 32979.3 33366.2 33614.5 33785.5 25046.2 25391.0 25501.7 25579.4 25936.9 09:47:52 INFO - PROCESS | 17324 | 09:47:52 INFO - PROCESS | 17324 | [#2] jquery.html Cycles:180 Average:34047.56 Median:3600.10 stddev:103699.99 (2880.5%) stddev-sans-first:103960.14 09:47:52 INFO - PROCESS | 17324 | Values: 412.7 417.4 423.5 426.3 449.8 19005.3 20526.4 20886.4 21475.5 21728.0 21256.3 21747.9 21902.9 21938.9 22199.9 5698.1 5936.8 5958.3 5958.8 6105.0 3953.7 4130.8 4132.5 4167.4 5323.1 4113.9 4115.4 4179.2 4183.4 4184.8 4121.0 4168.2 4170.1 4953.2 5726.5 5179.7 5191.3 5193.2 5195.0 5195.1 24918.6 25146.1 25291.4 25419.6 25837.2 2676.0 3018.4 3182.2 3220.3 3246.5 10605.6 10767.0 10913.3 10928.3 11232.7 1939.6 1958.9 1968.8 1987.6 1994.6 92235.0 94379.0 94712.5 95241.5 95977.0 11862.3 11895.0 11913.6 11982.4 12162.1 17135.7 17161.8 17173.1 17178.9 17189.7 8411.6 8722.9 8739.7 8759.7 8821.0 8042.4 8053.8 8322.9 8339.7 8346.8 5037.8 5064.9 5070.5 5152.6 5287.2 1992.9 2073.8 2106.2 2139.9 2148.1 879.0 895.9 900.0 901.2 904.8 19636.5 20605.6 20933.2 21019.5 21038.9 895.8 905.1 907.6 907.6 920.3 10808.2 11504.3 11540.2 11562.3 11593.1 605997.0 622424.0 631682.0 646516.0 646964.0 68279.0 95190.5 101911.0 103107.1 105419.0 1029.8 1044.4 1080.3 1081.0 1085.8 17138.8 18491.7 18661.3 18746.8 19099.0 47748.8 48145.3 48808.3 48970.0 49165.5 61317.0 61715.4 62893.0 63139.0 66033.0 6010.4 7946.8 8192.1 8894.3 9401.1 10162.3 13425.3 13826.2 13901.4 14273.7 7711.9 12241.4 12280.0 12628.0 12954.4 12307.5 12464.3 12656.7 12728.4 13009.9 11608.5 12474.6 12715.7 12844.0 13208.7 9087.4 9185.3 9323.3 9324.7 9333.2 9443.3 12083.6 12527.2 12554.6 12569.5 09:47:52 INFO - PROCESS | 17324 | 09:47:52 INFO - PROCESS | 17324 | [#3] mootools.html Cycles:180 Average:5562.47 Median:5024.69 stddev:3102.10 (61.7%) stddev-sans-first:3095.28 09:47:52 INFO - PROCESS | 17324 | Values: 1433.5 1442.9 1444.8 1445.8 1456.2 8096.5 8488.6 8545.4 8550.9 8551.9 7370.7 7607.5 7951.8 8211.6 8370.0 2315.2 2351.1 2352.3 2356.0 2361.6 2333.1 2361.1 2362.2 2369.1 2381.4 2002.3 2071.4 2270.9 2326.8 2338.9 2243.8 2260.2 2261.2 2261.9 2266.9 2206.5 2245.3 2291.1 2292.7 2297.3 8336.2 8391.9 8399.2 8401.2 8401.6 5227.9 5340.9 5350.6 5351.4 5364.2 3142.1 3261.8 3277.1 3293.7 3300.3 1271.9 1340.8 1353.3 1392.2 1415.5 11435.5 11490.3 11503.7 11533.7 11542.8 4568.4 4744.9 4808.3 4808.7 4933.5 10187.8 10211.1 10211.5 10218.1 10234.3 5445.3 5446.6 5447.8 5452.6 5456.0 4303.8 4438.5 4881.1 4882.4 4917.7 3898.9 3966.3 4030.7 4065.9 4069.7 1243.3 1271.3 1272.5 1291.0 1292.7 977.1 981.5 986.4 992.6 1010.5 5521.0 5646.9 5734.1 5771.3 5887.3 625.6 628.7 630.1 631.8 641.4 3700.5 3716.8 3783.8 3789.3 4072.9 10401.2 10630.4 10644.3 10671.6 10681.0 10489.7 10498.3 10507.9 10522.7 10525.4 7308.9 7580.5 7624.5 7640.7 7720.3 5466.3 5508.6 5570.1 5657.3 5722.1 9314.0 9321.5 9338.9 9362.9 9434.2 9549.5 9560.0 9636.9 9665.1 9675.5 6832.8 7034.1 7039.7 7494.9 7610.5 7622.6 8051.6 8107.7 8155.4 8194.4 7303.6 7328.8 7443.0 7559.8 7561.5 7120.3 7238.2 7278.3 7387.9 7453.6 6216.9 6284.2 6285.3 6286.6 6287.3 4813.8 4884.1 4895.5 4932.7 4957.3 5092.1 5273.3 5294.8 5320.3 5372.7 09:47:52 INFO - PROCESS | 17324 | 09:47:52 INFO - PROCESS | 17324 | [#4] prototype.html Cycles:180 Average:4689.49 Median:5387.98 stddev:1338.47 (24.8%) stddev-sans-first:1302.79 09:47:52 INFO - PROCESS | 17324 | Values: 392.3 404.2 407.5 409.2 413.1 5402.6 5405.5 5408.3 5408.6 5436.6 5213.2 5246.8 5281.7 5303.4 5379.8 4322.8 4330.9 4347.2 4352.7 4373.8 4281.9 4287.7 4306.5 4362.3 4363.4 3992.6 4007.0 4249.9 4260.9 4303.6 4269.6 4277.1 4278.2 4291.2 4301.9 3858.7 3868.6 3876.3 3880.4 3901.4 5074.8 5157.7 5211.6 5223.6 5231.7 4917.9 4928.8 4940.4 4960.7 4977.1 5587.4 5632.5 5637.5 5651.3 5690.5 3851.2 3988.5 4018.9 4269.6 4287.9 5737.4 5779.8 5783.8 5788.8 5814.4 4139.3 4161.0 4161.2 4186.9 4188.6 4121.6 4149.0 4163.5 4258.1 4261.3 4741.5 4742.6 4749.4 4758.3 4784.3 5545.5 5598.3 5645.5 5647.4 5653.1 1349.9 1391.6 1395.1 1399.1 1400.8 929.9 948.2 956.9 985.3 992.9 5202.2 5226.8 5266.9 5308.5 5324.9 5570.6 5636.6 5643.1 5647.9 5658.6 5080.2 5090.9 5177.0 5215.9 5275.5 2945.6 2957.5 2972.9 2978.4 2993.6 5579.6 5667.5 5713.2 5733.6 5742.4 5664.7 5666.6 5672.5 5678.2 5702.9 5704.2 5746.7 5759.5 5800.4 5808.2 5444.2 5511.5 5580.3 5590.6 5649.2 5526.8 5534.3 5540.0 5544.8 5550.3 5462.9 5673.7 5730.5 5776.0 5802.5 4009.3 4019.7 4025.8 4031.8 4062.3 5565.5 5573.0 5581.8 5635.3 5670.9 5272.0 5396.1 5410.8 5484.6 5499.1 5405.8 5435.3 5463.9 5469.9 5486.9 5398.2 5410.4 5413.9 5472.6 5541.6 5532.3 5603.7 5606.8 5655.5 5661.4 5485.8 5501.6 5517.7 5531.4 5534.2 09:47:52 INFO - PROCESS | 17324 | 09:47:52 INFO - PROCESS | 17324 | [#5] yui.html Cycles:180 Average:17614.63 Median:4382.07 stddev:21893.89 (499.6%) stddev-sans-first:21918.59 09:47:52 INFO - PROCESS | 17324 | Values: 729.6 741.3 769.6 770.8 788.9 18303.9 18588.2 18658.5 18735.3 19860.1 16600.3 18418.8 18446.7 18451.0 18494.5 723.9 752.6 758.8 759.0 759.8 763.0 766.7 767.0 767.1 767.3 796.8 797.9 799.0 799.1 799.7 791.3 794.0 794.8 795.1 795.5 578.5 578.9 579.3 579.4 579.7 16693.1 16736.2 16751.1 17434.9 17660.2 14307.1 14460.4 14580.9 14804.4 14870.9 11333.5 11337.4 11447.8 11500.4 11545.6 3688.4 3726.9 3786.9 3805.4 3816.5 56541.7 60740.7 63048.4 71377.3 81074.6 11232.6 11591.5 11636.7 11674.6 11758.9 22847.4 22897.3 22941.7 23098.1 23150.7 8048.2 8107.4 8168.0 8173.8 8307.4 4330.3 4347.9 4416.2 4492.9 4574.6 3469.8 3515.4 3525.3 3559.9 3569.3 610.1 615.3 618.9 621.0 625.0 731.7 744.8 747.5 758.3 784.4 10251.2 10602.8 10740.6 10903.4 11203.1 733.3 739.2 763.3 763.8 773.4 4828.1 5007.6 5120.7 5121.9 5125.7 76621.0 79920.6 80367.6 84228.2 84833.6 69842.0 71493.6 71599.6 71879.3 73199.6 60053.4 61123.0 61444.7 61802.7 64683.4 9243.2 9272.1 9394.9 9415.0 9442.0 36309.5 36647.8 37236.6 38000.8 46631.8 55275.2 56136.0 57027.7 57383.0 57514.4 13144.6 13157.4 13199.5 13319.2 13532.3 14353.0 14356.8 15075.8 15104.3 15634.3 13637.6 13676.2 13972.0 14251.6 14638.1 12620.6 12736.8 12897.5 13091.9 13149.8 13435.1 13520.0 13551.6 13697.6 13730.2 11308.8 11359.5 11675.9 11807.8 11888.8 10803.7 10815.4 10826.4 10895.8 10902.8 09:47:52 INFO - PROCESS | 17324 | -------- Summary: end -------- 09:47:52 INFO - PROCESS | 17324 | 09:47:53 INFO - TEST-INFO | 17324: exit 0 09:47:53 INFO - TEST-OK | dromaeo_css | took 1115116ms 09:47:53 INFO - TEST-START | kraken 09:47:53 INFO - operating with platform_type : linux_ 09:47:53 INFO - Initialising browser for kraken test... 09:47:53 INFO - TEST-INFO | started process 17623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS0FgmK/profile http://localhost:50062/getInfo.html) 09:47:56 INFO - PROCESS | 17623 | __metrics Screen width/height:1600/1200 09:47:56 INFO - PROCESS | 17623 | colorDepth:24 09:47:56 INFO - PROCESS | 17623 | Browser inner width/height: 1024/697 09:47:56 INFO - PROCESS | 17623 | __metrics 09:47:57 INFO - PROCESS | 17623 | 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" 09:47:57 INFO - PROCESS | 17623 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:47:58 INFO - PROCESS | 17623 | console.error: PushService: 09:47:58 INFO - PROCESS | 17623 | stateChangeProcessEnqueue: Error transitioning state 09:47:58 INFO - PROCESS | 17623 | UnknownError 09:47:58 INFO - TEST-INFO | 17623: exit 0 09:47:58 INFO - Browser initialized. 09:47:58 INFO - Running cycle 1/1 for kraken test... 09:47:58 INFO - TEST-INFO | started process 17710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS0FgmK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:48:10 INFO - PROCESS | 17710 | RSS: Main: 147828736 09:48:10 INFO - PROCESS | 17710 | 09:48:13 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50062/tests/kraken/driver.html?testName=audio-beat-detection) 09:48:14 INFO - PROCESS | 17710 | RSS: Main: 202203136 09:48:14 INFO - PROCESS | 17710 | 09:48:16 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50062/tests/kraken/driver.html?testName=audio-dft) 09:48:17 INFO - PROCESS | 17710 | RSS: Main: 182374400 09:48:17 INFO - PROCESS | 17710 | 09:48:20 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50062/tests/kraken/driver.html?testName=audio-fft) 09:48:20 INFO - PROCESS | 17710 | RSS: Main: 263692288 09:48:20 INFO - PROCESS | 17710 | 09:48:22 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50062/tests/kraken/driver.html?testName=audio-oscillator) 09:48:23 INFO - PROCESS | 17710 | RSS: Main: 175271936 09:48:23 INFO - PROCESS | 17710 | 09:48:25 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50062/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:48:26 INFO - PROCESS | 17710 | RSS: Main: 178929664 09:48:26 INFO - PROCESS | 17710 | 09:48:29 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50062/tests/kraken/driver.html?testName=imaging-darkroom) 09:48:29 INFO - PROCESS | 17710 | RSS: Main: 217997312 09:48:29 INFO - PROCESS | 17710 | 09:48:33 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50062/tests/kraken/driver.html?testName=imaging-desaturate) 09:48:33 INFO - PROCESS | 17710 | RSS: Main: 218333184 09:48:33 INFO - PROCESS | 17710 | 09:48:36 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50062/tests/kraken/driver.html?testName=json-parse-financial) 09:48:37 INFO - PROCESS | 17710 | RSS: Main: 216805376 09:48:37 INFO - PROCESS | 17710 | 09:48:38 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50062/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:48:39 INFO - PROCESS | 17710 | RSS: Main: 179113984 09:48:39 INFO - PROCESS | 17710 | 09:48:41 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50062/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:48:41 INFO - PROCESS | 17710 | RSS: Main: 185724928 09:48:41 INFO - PROCESS | 17710 | 09:48:43 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50062/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:48:44 INFO - PROCESS | 17710 | RSS: Main: 194252800 09:48:44 INFO - PROCESS | 17710 | 09:48:46 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:48:47 INFO - PROCESS | 17710 | RSS: Main: 198840320 09:48:47 INFO - PROCESS | 17710 | 09:48:50 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:48:51 INFO - PROCESS | 17710 | RSS: Main: 200847360 09:48:51 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | Cycle 1(1): loaded http://localhost:50062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50062/tests/kraken/driver.html?testName=ai-astar) 09:48:52 INFO - PROCESS | 17710 | RSS: Main: 252231680 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | __start_tp_report 09:48:52 INFO - PROCESS | 17710 | _x_x_mozilla_page_load 09:48:52 INFO - PROCESS | 17710 | _x_x_mozilla_page_load_details 09:48:52 INFO - PROCESS | 17710 | |i|pagename|runs| 09:48:52 INFO - PROCESS | 17710 | |0;ai-astar;110;112;113;111;110;111;111;110;111;110 09:48:52 INFO - PROCESS | 17710 | |1;audio-beat-detection;145;120;117;159;119;118;118;118;136;119 09:48:52 INFO - PROCESS | 17710 | |2;audio-dft;161;160;160;160;159;159;159;161;160;160 09:48:52 INFO - PROCESS | 17710 | |3;audio-fft;75;74;74;107;76;76;75;76;89;77 09:48:52 INFO - PROCESS | 17710 | |4;audio-oscillator;83;83;112;83;83;84;94;83;84;110 09:48:52 INFO - PROCESS | 17710 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;117 09:48:52 INFO - PROCESS | 17710 | |6;imaging-darkroom;147;147;146;146;147;148;148;147;147;147 09:48:52 INFO - PROCESS | 17710 | |7;imaging-desaturate;97;96;96;96;95;96;95;96;96;95 09:48:52 INFO - PROCESS | 17710 | |8;json-parse-financial;50;49;50;49;51;52;52;51;51;50 09:48:52 INFO - PROCESS | 17710 | |9;json-stringify-tinderbox;66;68;67;67;68;67;67;67;68;73 09:48:52 INFO - PROCESS | 17710 | |10;stanford-crypto-aes;83;83;84;82;82;82;82;81;82;85 09:48:52 INFO - PROCESS | 17710 | |11;stanford-crypto-ccm;126;131;126;123;127;124;129;125;216;138 09:48:52 INFO - PROCESS | 17710 | |12;stanford-crypto-pbkdf2;167;163;163;164;164;164;163;165;164;165 09:48:52 INFO - PROCESS | 17710 | |13;stanford-crypto-sha256-iterative;63;62;61;61;61;61;61;70;61;61 09:48:52 INFO - PROCESS | 17710 | __end_tp_report 09:48:52 INFO - PROCESS | 17710 | __start_cc_report 09:48:52 INFO - PROCESS | 17710 | _x_x_mozilla_cycle_collect,1607 09:48:52 INFO - PROCESS | 17710 | __end_cc_report 09:48:52 INFO - PROCESS | 17710 | __startTimestamp1484156932979__endTimestamp 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | ------- Summary: start ------- 09:48:52 INFO - PROCESS | 17710 | Number of tests: 14 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:0.99 (0.9%) stddev-sans-first:1.00 09:48:52 INFO - PROCESS | 17710 | Values: 110.0 112.0 113.0 111.0 110.0 111.0 111.0 110.0 111.0 110.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:119.50 stddev:14.72 (12.3%) stddev-sans-first:14.08 09:48:52 INFO - PROCESS | 17710 | Values: 145.0 120.0 117.0 159.0 119.0 118.0 118.0 118.0 136.0 119.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 09:48:52 INFO - PROCESS | 17710 | Values: 161.0 160.0 160.0 160.0 159.0 159.0 159.0 161.0 160.0 160.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#3] audio-fft Cycles:10 Average:79.90 Median:76.00 stddev:10.48 (13.8%) stddev-sans-first:10.97 09:48:52 INFO - PROCESS | 17710 | Values: 75.0 74.0 74.0 107.0 76.0 76.0 75.0 76.0 89.0 77.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:83.00 stddev:11.63 (14.0%) stddev-sans-first:12.06 09:48:52 INFO - PROCESS | 17710 | Values: 83.0 83.0 112.0 83.0 83.0 84.0 94.0 83.0 84.0 110.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:48:52 INFO - PROCESS | 17710 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 09:48:52 INFO - PROCESS | 17710 | Values: 147.0 147.0 146.0 146.0 147.0 148.0 148.0 147.0 147.0 147.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 09:48:52 INFO - PROCESS | 17710 | Values: 97.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:1.08 (2.1%) stddev-sans-first:1.13 09:48:52 INFO - PROCESS | 17710 | Values: 50.0 49.0 50.0 49.0 51.0 52.0 52.0 51.0 51.0 50.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:1.93 (2.9%) stddev-sans-first:1.94 09:48:52 INFO - PROCESS | 17710 | Values: 66.0 68.0 67.0 67.0 68.0 67.0 67.0 67.0 68.0 73.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:1.17 (1.4%) stddev-sans-first:1.24 09:48:52 INFO - PROCESS | 17710 | Values: 83.0 83.0 84.0 82.0 82.0 82.0 82.0 81.0 82.0 85.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:128.00 stddev:28.27 (22.1%) stddev-sans-first:29.72 09:48:52 INFO - PROCESS | 17710 | Values: 126.0 131.0 126.0 123.0 127.0 124.0 129.0 125.0 216.0 138.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.00 stddev:1.23 (0.7%) stddev-sans-first:0.78 09:48:52 INFO - PROCESS | 17710 | Values: 167.0 163.0 163.0 164.0 164.0 164.0 163.0 165.0 164.0 165.0 09:48:52 INFO - PROCESS | 17710 | 09:48:52 INFO - PROCESS | 17710 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:61.00 stddev:2.82 (4.6%) stddev-sans-first:2.98 09:48:52 INFO - PROCESS | 17710 | Values: 63.0 62.0 61.0 61.0 61.0 61.0 61.0 70.0 61.0 61.0 09:48:52 INFO - PROCESS | 17710 | -------- Summary: end -------- 09:48:52 INFO - PROCESS | 17710 | 09:48:53 INFO - TEST-INFO | 17710: exit 0 09:48:54 INFO - TEST-OK | kraken | took 60369ms 09:48:54 INFO - SUITE-END | took 1175s 09:48:54 INFO - Completed test suite (00:19:35) 09:48:54 INFO - javascript benchmark 09:48:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.9057728268153, 3170.073389643629, 3200.327931134462, 3204.7275981541566, 3207.102011436797, 5363.9463605363935, 5407.3781515125775, 5431.701256430894, 5466.1527463243165, 5498.202760599711, 5462.262594549735, 5517.393086760463, 5542.61201715879, 5559.610827242094, 5577.163425486169, 4981.053599816041, 5006.424261209971, 5010.749462526877, 5044.545990860822, 5072.213806859924, 5091.414487333948, 5172.353455818023, 5195.6622819516615, 5196.220566914974, 5223.582113430916, 4930.211166213388, 4954.232094025432, 5049.065922804293, 5073.873153171164, 5111.207762796773, 4962.553370196663, 4974.502549745032, 4997.400311962588, 5000.699958002495, 5078.568321692661, 4950.43070046942, 4966.50334966504, 4968.925466118011, 4971.428285747149, 5022.045811295842, 5433.429489903543, 5522.0, 5542.4457554244655, 5546.77812887484, 5558.833235002957, 5847.795327163529, 5898.203742494751, 5944.4352786485215, 5952.851178720567, 6032.487238584726, 5979.372165922559, 5994.7901823436405, 6000.519958403317, 6007.189029481008, 6012.278526576795, 5567.916481252784, 5570.972145139248, 5574.080276754331, 5577.27495425592, 5580.162975553659, 5881.206037185011, 5899.587028908021, 5948.67282299469, 6019.909701354483, 6034.607750496204, 5738.024535828919, 5772.307323121252, 5774.711264436762, 5781.768729250867, 5787.131930210502, 5847.795327163529, 5858.912116318259, 5859.20900678403, 5868.413158684183, 5978.192943952511, 5790.768369265266, 5819.068948968229, 5842.0, 5866.0, 5883.14694369314, 5935.643861368331, 5939.109133629903, 5945.583809133405, 5967.104934259895, 5985.132155837467, 4608.5621865922685, 4614.792334344963, 4615.446146462446, 4620.099080679235, 4655.3249778782565, 4025.496812898388, 4029.2143032108456, 4035.5157381114454, 4055.858044968412, 4077.8368865245056, 5572.164175373645, 5580.804671836548, 5580.888382232332, 5612.887742245214, 5626.578006649518, 5953.077273022688, 5955.76176952917, 5957.195778569924, 5958.463738263577, 5961.850953726192, 5432.483914028161, 5476.561875049986, 5518.53092487135, 5579.0515612346, 5583.609147359646, 5063.696178229318, 5091.669041512364, 5102.744862756847, 5124.410692770379, 5150.536451719363, 6137.110119032715, 6180.351063138396, 6190.41191086846, 6191.566590338633, 6191.84520386994, 5680.062789639664, 5738.0, 5931.258592675916, 5984.730687119177, 5995.640261584319, 6084.39156084388, 6125.173101631222, 6133.754649813957, 6161.44546990773, 6161.537884658758, 5843.152742852178, 5845.386234445322, 5847.947369473365, 5865.384134665798, 5922.674252916131, 5740.6268592541355, 5936.436038576328, 5938.435848594377, 5939.673317967553, 5939.792107276225, 5588.748506317144, 5737.311522617312, 5739.225204597493, 5793.188953546422, 5883.323417807007, 5775.133729940542, 5834.679092649945, 5835.183074369676, 5836.358000619844, 5844.444777746107, 5666.546676265806, 5710.8001219957105, 5835.79574714883, 5839.153322768259, 5841.18223448726, 5818.796342128006, 5855.765769369177, 5886.58793884424, 5892.941070589411, 5985.132155837467, 5752.33848107473, 5781.739821708117, 5783.3638299787835, 5785.218995435563, 5786.826395208151], "value": 5460.515909513601, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.6582316388411, 583.778164297567, 600.5885968111843, 618.7494064903713, 713.7359177104472, 33638.49542256868, 43828.3425748614, 44168.999999999956, 44294.77852610732, 49036.264456033095, 45720.771396142976, 46080.308795368095, 46206.30690539644, 46268.76118671694, 46298.537014629845, 8711.782205444882, 8807.119288071206, 8954.104589541043, 9129.315301352392, 9144.131307525808, 10729.08802751767, 10966.06788422985, 10970.341779493216, 11362.886371136265, 11366.829497557543, 11039.39283339416, 11140.777184456307, 11147.108231341514, 11147.832782508269, 11149.052330551913, 11156.0, 11157.27477713946, 11172.0, 11203.551857925673, 11218.102551795837, 10801.67594972152, 10890.782184356347, 10892.61875834342, 10893.891061089445, 10895.128389728803, 43839.56160438387, 44116.55883441157, 44167.33748993768, 44195.77902110501, 44225.55774442247, 4201.096764195712, 4238.237117318881, 4294.914101717948, 4344.565543445662, 4387.0, 32595.18512037194, 32787.18032049194, 32991.50512742311, 33273.833630831934, 34936.475952860725, 3683.631636836322, 3741.1021354874633, 3763.303788799081, 3767.7174211934216, 3796.7152463565344, 346920.0, 347561.0, 347706.0, 348533.0, 348553.0, 62123.689381553704, 62313.376866231665, 62562.0, 63031.369686303464, 63088.0, 65636.0, 65911.0, 65913.34086659168, 65949.67025164844, 65970.46561153462, 16188.75716864248, 16680.49958501247, 16699.08155051484, 16709.415170468976, 16717.916410418115, 11309.547618095348, 11562.653120406401, 11597.304161750322, 11726.824097638542, 12872.0, 16095.678086438205, 16620.501384958472, 17862.642747144986, 18214.726779098324, 18229.7265541017, 6380.617162970237, 6413.743450262031, 6429.357064293533, 6442.486015786287, 6452.548321617535, 940.8823897012874, 942.599395257013, 944.5135755086136, 949.886013678363, 966.1739212972948, 30662.54006189909, 32220.516692249636, 32539.0, 32903.81800590467, 32981.835090824876, 1051.9105876000626, 1054.947252637365, 1068.6374872038214, 1069.4652673663168, 1078.2129045796455, 14638.780418293734, 15401.383944642314, 15428.460003899809, 15480.458183963507, 15679.843201567839, 473107.0, 473191.0, 476276.0, 476812.0, 478060.0, 55388.44611553913, 55692.72153639206, 55720.44279557234, 55722.16416753752, 55800.44199558034, 1430.8139941807706, 1445.645816774897, 1465.1282486920265, 1466.4793998130724, 1469.6252455623749, 26942.59586106171, 27677.33170098017, 27832.721672783013, 28425.715742843135, 28789.56815647809, 46001.0, 46273.3059004122, 46392.30411543897, 46466.76766616145, 46521.302180467996, 393756.0, 394528.0, 395592.0, 395689.0, 395763.0, 25157.371065723502, 25462.74537254678, 25526.489470210865, 26448.338791529597, 26981.865090674422, 39624.0, 43108.78445607752, 43136.35295470508, 43212.567874320855, 43405.0, 36969.44545831868, 37201.25597488089, 37414.8129259352, 37499.250014999, 37998.43002354912, 35868.0, 37069.44395834119, 37133.62866371302, 37646.2470750578, 38259.80870095743, 36560.0, 36572.81713591521, 36768.0, 36821.0, 37373.81313093417, 31287.374252515277, 32979.34041319208, 33366.16584585308, 33614.49578256377, 33785.49321760225, 25046.248612541654, 25391.0, 25501.744982550677, 25579.36051598725, 25936.870315648302], "value": 19895.126587337487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.6678024190525, 417.44062955639447, 423.4960397127416, 426.32001956878776, 449.8223201835275, 19005.334813281537, 20526.38420847375, 20886.37340879772, 21475.46311342217, 21728.0, 21256.29949604032, 21747.891260543714, 21902.89048554759, 21938.89030554849, 22199.889000554973, 5698.0626586960425, 5936.821895343125, 5958.344582095966, 5958.821235362924, 6105.0, 3953.7034722395792, 4130.8141133648905, 4132.5040995080635, 4167.374893765929, 5323.148296272597, 4113.8971525711795, 4115.444415003981, 4179.226843034034, 4183.3515805050265, 4184.811683474251, 4120.990357362435, 4168.24971505129, 4170.124273902469, 4953.182724850395, 5726.484616384504, 5179.689218646893, 5191.273221748958, 5193.246979187997, 5194.974025129888, 5195.116830138885, 24918.626220606704, 25146.11988580391, 25291.367715807068, 25419.61870571943, 25837.224883253533, 2676.0, 3018.44158830617, 3182.220356012792, 3220.339830334799, 3246.4967929970894, 10605.628802991858, 10767.0, 10913.345199288067, 10928.289661171999, 11232.66302010941, 1939.6120775844888, 1958.9314373996983, 1968.803119688034, 1987.6124155789628, 1994.6409646263667, 92235.0, 94379.0, 94712.52643736805, 95241.52379238128, 95977.0, 11862.288262704093, 11895.0, 11913.583024594098, 11982.382378378981, 12162.08784341178, 17135.74296385555, 17161.828381716274, 17173.055481948613, 17178.91410542964, 17189.656206875792, 8411.579421028924, 8722.912770872337, 8739.737807865775, 8759.693410730593, 8820.955895220612, 8042.437029407885, 8053.758387248392, 8322.916770832215, 8339.666413343519, 8346.8330633387, 5037.773300201499, 5064.924026139611, 5070.467600901852, 5152.613553983391, 5287.154055351202, 1992.85053620979, 2073.782252863458, 2106.2083759447073, 2139.9037043333087, 2148.1407437025314, 878.9516576588348, 895.8566629339274, 899.9550022498848, 901.2429559170329, 904.7738065483629, 19636.509087272647, 20605.587888242153, 20933.162673493196, 21019.474513137295, 21038.89480552618, 895.8297923394534, 905.063259526387, 907.577976241051, 907.6369452219166, 920.3235621817959, 10808.243422960317, 11504.309741415542, 11540.192186546861, 11562.30626162433, 11593.072554195644, 605997.0, 622424.0, 631682.0, 646516.0, 646964.0, 68279.0, 95190.5240473807, 101911.0, 103107.08054412558, 105419.0, 1029.7528593137592, 1044.4151275285865, 1080.3247970018738, 1081.0270756319376, 1085.755704966392, 17138.828611713725, 18491.72262416038, 18661.253549857855, 18746.812531874508, 19099.0, 47748.761256193495, 48145.27782083341, 48808.267875981175, 48970.0, 49165.508344916096, 61317.0, 61715.38284617096, 62893.0, 63139.0, 66033.0, 6010.398960103955, 7946.841063178819, 8192.139825318494, 8894.28845692356, 9401.059894010545, 10162.339447935861, 13425.328733563478, 13826.170429774245, 13901.374438150106, 14273.717884634361, 7711.922880771121, 12241.449134788778, 12280.0, 12628.0, 12954.417051232529, 12307.507699691912, 12464.252144871336, 12656.74686506283, 12728.363581821057, 13009.934950325567, 11608.477618507357, 12474.625761227178, 12715.745685086431, 12844.0, 13208.669783255495, 9087.36388452802, 9185.311101667268, 9323.347365684336, 9324.720258391988, 9333.160015598629, 9443.291753118681, 12083.57707480234, 12527.244006318595, 12554.623361299176, 12569.497220111092], "value": 9535.8496929879, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.5197708767562, 1442.884569234461, 1444.826620805503, 1445.768677011677, 1456.1627064437948, 8096.514209147448, 8488.61801218945, 8545.401821872472, 8550.871736923935, 8551.914480855197, 7370.668319925603, 7607.467477276579, 7951.840963180733, 8211.589420528979, 8370.037445693748, 2315.1896836107353, 2351.0595761695286, 2352.329586067971, 2355.9764402356013, 2361.551305252005, 2333.148400833692, 2361.0791791201445, 2362.244081893795, 2369.052379048377, 2381.3570336009266, 2002.2591641092815, 2071.440711008027, 2270.897809598564, 2326.7905888470036, 2338.9064437422485, 2243.7756224377595, 2260.242818655752, 2261.2424837679396, 2261.9095236190533, 2266.9433264168365, 2206.481476852938, 2245.348848833836, 2291.0950174680906, 2292.713410823647, 2297.287840769367, 8336.166383361615, 8391.909051823284, 8399.160083991552, 8401.201885820898, 8401.621927013299, 5227.895442091137, 5340.946590534084, 5350.5987050971335, 5351.384590772033, 5364.168553874156, 3142.1359126240236, 3261.8205998670064, 3277.147941535194, 3293.6870997255223, 3300.3069355435387, 1271.8600953895063, 1340.7988801679826, 1353.343628340254, 1392.2133994293192, 1415.469199050356, 11435.542578296858, 11490.253133546375, 11503.654890353302, 11533.653990380302, 11542.769144617061, 4568.360429539867, 4744.928826067612, 4808.326834243208, 4808.735519546389, 4933.50664933511, 10187.847182292271, 10211.081002709792, 10211.540480678239, 10218.080372766486, 10234.334768240189, 5445.292112025411, 5446.618736688473, 5447.754851031713, 5452.563794896399, 5456.045192091368, 4303.849365272201, 4438.489573699066, 4881.145799485076, 4882.438519570223, 4917.680350777188, 3898.863539776094, 3966.2860685076384, 4030.7380020298588, 4065.8780236592947, 4069.674426045909, 1243.3348158735034, 1271.313490715022, 1272.5228039485194, 1290.9741805164033, 1292.6509842342514, 977.0913050862624, 981.4601968917067, 986.3687240166299, 992.6029588164791, 1010.4846528270635, 5521.033819081645, 5646.85882852932, 5734.111212762028, 5771.278590176228, 5887.322957859816, 625.5746092657037, 628.6793735194992, 630.146151964082, 631.8262477818545, 641.3682522715216, 3700.50043244164, 3716.832742526593, 3783.810809459516, 3789.317922773927, 4072.857449989236, 10401.167906567456, 10630.362178269328, 10644.308119972176, 10671.57313707443, 10681.0, 10489.737756555995, 10498.265121441425, 10507.94746026265, 10522.684319470429, 10525.42110183932, 7308.853822923512, 7580.507267027626, 7624.504407213624, 7640.656170472342, 7720.3051725344985, 5466.34403871522, 5508.55931525469, 5570.136628822539, 5657.349404818498, 5722.055860782924, 9314.0, 9321.533923303943, 9338.859917101114, 9362.859557106513, 9434.198093161884, 9549.52252387364, 9559.952200238955, 9636.855447168158, 9665.130138287588, 9675.516224188621, 6832.795016149524, 7034.050403195503, 7039.718411263492, 7494.925050749423, 7610.505317154367, 7622.58075805836, 8051.557164356017, 8107.71622993216, 8155.429119961783, 8194.38542109356, 7303.598302093435, 7328.78013659591, 7442.96278518604, 7559.811004724926, 7561.508501947355, 7120.252373500708, 7238.167610724834, 7278.272172782679, 7387.889181662387, 7453.590052547162, 6216.937830621636, 6284.183056202847, 6285.277193122849, 6286.591371560834, 6287.2769631492965, 4813.78337974799, 4884.12085824555, 4895.461499235153, 4932.654714169974, 4957.330760347451, 5092.0579692756955, 5273.288106105627, 5294.814681486284, 5320.255164277081, 5372.704501252469], "value": 4468.733709094465, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.2586311870565, 404.1694318176148, 407.5170922456889, 409.1673444540361, 413.1468517511339, 5402.621816472843, 5405.48646379014, 5408.323959505066, 5408.621396502246, 5436.592255580837, 5213.244079608455, 5246.842594722155, 5281.735913204334, 5303.443138470463, 5379.81170659027, 4322.84870029549, 4330.913381732364, 4347.174036932988, 4352.673549483786, 4373.781310934456, 4281.850135245267, 4287.721298115628, 4306.547812479692, 4362.345648152771, 4363.4327537420095, 3992.580779018205, 4006.979965100185, 4249.8950272929105, 4260.8721738347895, 4303.634191093761, 4269.6370808481315, 4277.123189746095, 4278.1871444425615, 4291.163223171483, 4301.935470967954, 3858.7298889077774, 3868.613138686137, 3876.341022026262, 3880.4373365862075, 3901.3809269153267, 5074.847754567369, 5157.6647517911215, 5211.557017653504, 5223.6343455958095, 5231.712255825928, 4917.901641967176, 4928.753562321869, 4940.382452193476, 4960.70235785854, 4977.068116188207, 5587.38538760736, 5632.46491583303, 5637.46444087811, 5651.2935883014625, 5690.459406356431, 3851.1912498375373, 3988.481497405348, 4018.9397159042637, 4269.615734583902, 4287.871363859089, 5737.39757325479, 5779.826605201851, 5783.797567085132, 5788.797392091299, 5814.447627475383, 4139.317012692872, 4160.979195104005, 4161.169085602325, 4186.874393768192, 4188.623023927861, 4121.567235440296, 4149.0, 4163.458750362433, 4258.1057977825, 4261.2542805009, 4741.525847415231, 4742.644301677319, 4749.4063242094735, 4758.3100450434495, 4784.330193772875, 5545.528630066409, 5598.3282006159525, 5645.5483561314995, 5647.37878833328, 5653.088659340443, 1349.8987575931844, 1391.631217727303, 1395.1350162899068, 1399.0626280392162, 1400.775875859878, 929.9395539289925, 948.2319321349729, 956.9425834449955, 985.3347842146749, 992.9007099290013, 5202.2196670499725, 5226.778619086873, 5266.867623460974, 5308.495692909168, 5324.946750532523, 5570.610057296031, 5636.605437619327, 5643.125315576092, 5647.915281270784, 5658.603897727202, 5080.23796430531, 5090.872728181825, 5177.0, 5215.947840521546, 5275.525202731773, 2945.572891930658, 2957.5267957126757, 2972.8810847566288, 2978.4340975215073, 2993.5509673548704, 5579.609427340129, 5667.489925906688, 5713.228714123623, 5733.627314224562, 5742.368339482654, 5664.68844213564, 5666.631668941505, 5672.517835983905, 5678.205051292823, 5702.942970570324, 5704.22992895962, 5746.712664366765, 5759.452851979056, 5800.4199580042505, 5808.186853840551, 5444.223446042468, 5511.53151982086, 5580.330360356783, 5590.596043701247, 5649.209110724584, 5526.839363733661, 5534.308211473566, 5540.033288182798, 5544.805931792368, 5550.335838797319, 5462.945370546244, 5673.744681489426, 5730.484256416776, 5776.036147709799, 5802.506786923159, 4009.2983727848095, 4019.738716983387, 4025.8188381523487, 4031.8106158683845, 4062.309407400808, 5565.471280228372, 5572.96586745843, 5581.804636837691, 5635.295588051494, 5670.886582268414, 5272.0, 5396.140045775745, 5410.78356865721, 5484.561235101102, 5499.1476321170285, 5405.837824865261, 5435.266239057677, 5463.863403414946, 5469.9179512306555, 5486.890262194814, 5398.2442458056685, 5410.404855465974, 5413.864653383697, 5472.589555783253, 5541.556675466034, 5532.253145825262, 5603.719814009365, 5606.775728970795, 5655.462731040545, 5661.377248502579, 5485.835424937259, 5501.63429725222, 5517.69652669107, 5531.391546929754, 5534.181414823759], "value": 4278.766806074784, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.5877829026603, 741.347614099593, 769.5844244108182, 770.7764748223016, 788.8974433323668, 18303.908480457594, 18588.16353264103, 18658.533536661573, 18735.25058997642, 19860.106295216712, 16600.25298861551, 18418.815811841876, 18446.723299150523, 18451.0, 18494.537636559093, 723.9420846332281, 752.5672738175543, 758.7951253161643, 758.9886151707728, 759.7948553890474, 762.9694812207505, 766.7469734987441, 767.0182166826443, 767.0833354141803, 767.2557619109483, 796.8167321516055, 797.9082405523382, 798.9640466179006, 799.0970203669845, 799.7041094794905, 791.2799352589174, 793.996030019852, 794.8450052239787, 795.1094773853292, 795.4988357334871, 578.4504720515486, 578.8639669677623, 579.3192998227066, 579.4379451931619, 579.7304253522133, 16693.081880496567, 16736.16319184036, 16751.07869067201, 17434.91282543592, 17660.205290761947, 14307.141571505743, 14460.421583136767, 14580.927095364455, 14804.40782368704, 14870.851291487055, 11333.489992950337, 11337.37644429556, 11447.828282575769, 11500.367479788609, 11545.595904143314, 3688.4467329900463, 3726.9440958385644, 3786.8863934081746, 3805.429185622179, 3816.484774555427, 56541.71729141328, 60740.69629651823, 63048.36951630517, 71377.28622713758, 81074.59462702648, 11232.55069797199, 11591.478383472764, 11636.650900473, 11674.649760507198, 11758.88241117595, 22847.428814279443, 22897.313080607277, 22941.655875161887, 23098.07607695707, 23150.65274020891, 8048.154943730941, 8107.391945603986, 8167.959160204161, 8173.836523269501, 8307.376946728898, 4330.307150855911, 4347.934780978288, 4416.205083085076, 4492.932606010847, 4574.634029277717, 3469.774464659789, 3515.367233897923, 3525.294941011808, 3559.875404360887, 3569.3396721606587, 610.0513701194596, 615.2649528330066, 618.9195404597464, 620.981370558884, 625.0499241153422, 731.7438896386328, 744.7840126363402, 747.484235877243, 758.2531206761336, 784.3568274015366, 10251.231157663056, 10602.840957385646, 10740.570377184982, 10903.400312982703, 11203.103751699844, 733.3399940053994, 739.2053542441896, 763.2634507700096, 763.7823220382276, 773.3697036914897, 4828.130936431476, 5007.599392048627, 5120.667156634807, 5121.923171152435, 5125.718085505333, 76621.0, 79920.60039699764, 80367.59816200999, 84228.15771842326, 84833.57583212169, 69842.0, 71493.642531787, 71599.64200178966, 71879.28120718726, 73199.63400182965, 60053.399466005656, 61123.0, 61444.69277653672, 61802.69098654568, 64683.353166468674, 9243.168114869424, 9272.119148680864, 9394.859077113986, 9414.95292523533, 9442.0, 36309.45535817018, 36647.81676091602, 37236.627633723314, 38000.80999594984, 46631.766841165576, 55275.17087243614, 56136.0, 57027.714861425426, 57383.0, 57514.424855750905, 13144.60566183016, 13157.407916643582, 13199.472021119047, 13319.200847949154, 13532.255725935169, 14353.0, 14356.784648230494, 15075.773863391838, 15104.320305586494, 15634.27548661365, 13637.590872273848, 13676.247806370746, 13972.0, 14251.57245282643, 14638.121712697272, 12620.621381358575, 12736.808947865975, 12897.484100636244, 13091.869081309445, 13149.802752958522, 13435.12671676338, 13519.986001050158, 13551.569149994237, 13697.589072327846, 13730.244836533688, 11308.83036754433, 11359.54561817518, 11675.941620292184, 11807.817184680089, 11888.76222475563, 10803.675889723321, 10815.35107893529, 10826.350418974887, 10895.782084358427, 10902.781944361226], "value": 7292.544057707627, "unit": "score"}], "name": "dromaeo_css", "value": 7243.712805903766, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 113.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 120.0, 117.0, 159.0, 119.0, 118.0, 118.0, 118.0, 136.0, 119.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 159.0, 159.0, 159.0, 161.0, 160.0, 160.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 107.0, 76.0, 76.0, 75.0, 76.0, 89.0, 77.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 112.0, 83.0, 83.0, 84.0, 94.0, 83.0, 84.0, 110.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 49.0, 51.0, 52.0, 52.0, 51.0, 51.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 73.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 82.0, 82.0, 82.0, 82.0, 81.0, 82.0, 85.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 126.0, 123.0, 127.0, 124.0, 129.0, 125.0, 216.0, 138.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 163.0, 164.0, 164.0, 164.0, 163.0, 165.0, 164.0, 165.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 70.0, 61.0, 61.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1490.8999999999999, "alertThreshold": 2.0}]} 09:48:54 INFO - Return code: 0 09:48:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:48:54 INFO - # TBPL SUCCESS # 09:48:54 INFO - Running post-action listener: _resource_record_post_action 09:48:54 INFO - [mozharness: 2017-01-11 17:48:54.283239Z] Finished run-tests step (success) 09:48:54 INFO - Running post-run listener: _resource_record_post_run 09:48:54 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403083264; Read time: 20; Write time: 250556 09:48:54 INFO - TinderboxPrint: CPU usage
13.1% 09:48:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:48:54 INFO - TinderboxPrint: I/O write bytes / time
403,083,264 / 250,556 09:48:54 INFO - TinderboxPrint: CPU idle
8,275.5 (86.9%) 09:48:54 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 09:48:54 INFO - TinderboxPrint: Swap in / out
0 / 0 09:48:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105742336; Read time: 0; Write time: 67940 09:48:54 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297340928; Read time: 20; Write time: 182616 09:48:54 INFO - Running post-run listener: _upload_blobber_files 09:48:54 INFO - Blob upload gear active. 09:48:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:48: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 09:48: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'] 09:48: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 09:48:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:48:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:48:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:48:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:56 INFO - (blobuploader) - INFO - Done attempting. 09:48:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:48:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:57 INFO - (blobuploader) - INFO - Done attempting. 09:48:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:57 INFO - (blobuploader) - INFO - Done attempting. 09:48:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:49:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:01 INFO - (blobuploader) - INFO - Done attempting. 09:49:01 INFO - (blobuploader) - INFO - Iteration through files over. 09:49:01 INFO - Return code: 0 09:49:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:49:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:49:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47eacd4a002a5f42e0e418b50034375d22d9daa213424e7aeda0a85a59bc69d7318e7d21dad29db2d95bf0e59226b8e140d788909ef6f1c9cc25e2080b63e39b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/457bb09ea48ce931adecc4c3fecfda501ead84cab88a7d3ba99a821e86a9d17e3dd4007768c6bbbbf0a02bd9c8ff06547dd93eb1d7c8fcbd625d3589c38e4b17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ade5aef9e4bc4865ec261584ac830c9e2e32f010d7573dca0708922d7dbd50d41c022be14d39437a68d53055b6f6739307f6cd526302096e6be3627ce19320a5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5171d9492bd442a7ca0fcefe0ee49f24f2a6ef2bb58de8c4c05be52f9dd9834c027b76e0493c9a16335af10ec75d2df6867f27c55a69c4d260e11facad2ba581"} 09:49:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:49:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:49:01 INFO - Contents: 09:49:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47eacd4a002a5f42e0e418b50034375d22d9daa213424e7aeda0a85a59bc69d7318e7d21dad29db2d95bf0e59226b8e140d788909ef6f1c9cc25e2080b63e39b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/457bb09ea48ce931adecc4c3fecfda501ead84cab88a7d3ba99a821e86a9d17e3dd4007768c6bbbbf0a02bd9c8ff06547dd93eb1d7c8fcbd625d3589c38e4b17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ade5aef9e4bc4865ec261584ac830c9e2e32f010d7573dca0708922d7dbd50d41c022be14d39437a68d53055b6f6739307f6cd526302096e6be3627ce19320a5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5171d9492bd442a7ca0fcefe0ee49f24f2a6ef2bb58de8c4c05be52f9dd9834c027b76e0493c9a16335af10ec75d2df6867f27c55a69c4d260e11facad2ba581"} 09:49:01 INFO - Running post-run listener: copy_logs_to_upload_dir 09:49:01 INFO - Copying logs to upload dir... 09:49:01 INFO - mkdir: /builds/slave/test/build/upload/logs 09:49:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.362527 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-11 09:49:01.168100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 09:49:01.173526) ========= 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=0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565 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/47eacd4a002a5f42e0e418b50034375d22d9daa213424e7aeda0a85a59bc69d7318e7d21dad29db2d95bf0e59226b8e140d788909ef6f1c9cc25e2080b63e39b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/457bb09ea48ce931adecc4c3fecfda501ead84cab88a7d3ba99a821e86a9d17e3dd4007768c6bbbbf0a02bd9c8ff06547dd93eb1d7c8fcbd625d3589c38e4b17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ade5aef9e4bc4865ec261584ac830c9e2e32f010d7573dca0708922d7dbd50d41c022be14d39437a68d53055b6f6739307f6cd526302096e6be3627ce19320a5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5171d9492bd442a7ca0fcefe0ee49f24f2a6ef2bb58de8c4c05be52f9dd9834c027b76e0493c9a16335af10ec75d2df6867f27c55a69c4d260e11facad2ba581"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011862 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484145356/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/47eacd4a002a5f42e0e418b50034375d22d9daa213424e7aeda0a85a59bc69d7318e7d21dad29db2d95bf0e59226b8e140d788909ef6f1c9cc25e2080b63e39b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/457bb09ea48ce931adecc4c3fecfda501ead84cab88a7d3ba99a821e86a9d17e3dd4007768c6bbbbf0a02bd9c8ff06547dd93eb1d7c8fcbd625d3589c38e4b17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ade5aef9e4bc4865ec261584ac830c9e2e32f010d7573dca0708922d7dbd50d41c022be14d39437a68d53055b6f6739307f6cd526302096e6be3627ce19320a5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5171d9492bd442a7ca0fcefe0ee49f24f2a6ef2bb58de8c4c05be52f9dd9834c027b76e0493c9a16335af10ec75d2df6867f27c55a69c4d260e11facad2ba581"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 09:49:01.199960) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 09:49:01.200353) ========= 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=0333a256a5e4f052382dd180000001b1-1484155704.323851-440070565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 09:49:01.283080) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 09:49:01.283440) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 09:49:01.283750) ========= ========= Total master_lag: 0.17 =========