builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-044 starttime: 1482266046.5 results: success (0) buildid: 20161220114253 builduid: 9575e87b407a436aaaed81bd4e774fb6 revision: 7083c0d30e75fc102c715887af9faec933e936f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:06.498280) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:06.498755) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:06.499241) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:06.545054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:06.545368) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-20 12:34:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-12-20 12:34:08 (37.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087966 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:06.649438) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:06.649766) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013334 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:06.727612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:06.727979) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7083c0d30e75fc102c715887af9faec933e936f8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7083c0d30e75fc102c715887af9faec933e936f8 --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=88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-20 12:34:08,322 truncating revision to first 12 chars 2016-12-20 12:34:08,322 Setting DEBUG logging. 2016-12-20 12:34:08,322 attempt 1/10 2016-12-20 12:34:08,322 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7083c0d30e75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 12:34:08,628 unpacking tar archive at: mozilla-central-7083c0d30e75/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674753 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:07.418813) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:07.419272) ========= script_repo_revision: 7083c0d30e75fc102c715887af9faec933e936f8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:07.419707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:07.420030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 12:34:07.429145) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-20 12:34:07.429483) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:34:09 INFO - MultiFileLogger online at 20161220 12:34:09 in /builds/slave/test 12:34:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 12:34:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:34:09 INFO - {'append_to_log': False, 12:34:09 INFO - 'base_work_dir': '/builds/slave/test', 12:34:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:34:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:34:09 INFO - 'branch': 'Firefox-Non-PGO', 12:34:09 INFO - 'buildbot_json_path': 'buildprops.json', 12:34:09 INFO - 'config_files': ('talos/linux_config.py',), 12:34:09 INFO - 'default_actions': ('clobber', 12:34:09 INFO - 'read-buildbot-config', 12:34:09 INFO - 'download-and-extract', 12:34:09 INFO - 'populate-webroot', 12:34:09 INFO - 'create-virtualenv', 12:34:09 INFO - 'install', 12:34:09 INFO - 'run-tests'), 12:34:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:34:09 INFO - 'download_minidump_stackwalk': True, 12:34:09 INFO - 'download_symbols': 'ondemand', 12:34:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:34:09 INFO - 'tooltool.py': '/tools/tooltool.py', 12:34:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:34:09 INFO - '/tools/misc-python/virtualenv.py')}, 12:34:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:34:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:34:09 INFO - 'installer_path': 'installer.exe', 12:34:09 INFO - 'log_level': 'info', 12:34:09 INFO - 'log_name': 'talos', 12:34:09 INFO - 'log_to_console': True, 12:34:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:34:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:34:09 INFO - 'opt_config_files': (), 12:34:09 INFO - 'pip_index': False, 12:34:09 INFO - 'sps_profile': False, 12:34:09 INFO - 'sps_profile_interval': 0, 12:34:09 INFO - 'suite': 'dromaeojs', 12:34:09 INFO - 'system_bits': '32', 12:34:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:34:09 INFO - 'title': 'talos-linux64-ix-044', 12:34:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:34:09 INFO - 'use_talos_json': True, 12:34:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:34:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:34:09 INFO - 'work_dir': 'build'} 12:34:09 INFO - [mozharness: 2016-12-20 20:34:09.118418Z] Running clobber step. 12:34:09 INFO - Running pre-action listener: _resource_record_pre_action 12:34:09 INFO - Running main action method: clobber 12:34:09 INFO - rmtree: /builds/slave/test/build 12:34:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:34:09 INFO - Running post-action listener: _resource_record_post_action 12:34:09 INFO - [mozharness: 2016-12-20 20:34:09.580128Z] Finished clobber step (success) 12:34:09 INFO - [mozharness: 2016-12-20 20:34:09.580229Z] Running read-buildbot-config step. 12:34:09 INFO - Running pre-action listener: _resource_record_pre_action 12:34:09 INFO - Running main action method: read_buildbot_config 12:34:09 INFO - Using buildbot properties: 12:34:09 INFO - { 12:34:09 INFO - "project": "", 12:34:09 INFO - "product": "firefox", 12:34:09 INFO - "script_repo_revision": "production", 12:34:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:34:09 INFO - "repository": "", 12:34:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 12:34:09 INFO - "buildid": "20161220114253", 12:34:09 INFO - "pgo_build": "False", 12:34:09 INFO - "basedir": "/builds/slave/test", 12:34:09 INFO - "buildnumber": 885, 12:34:09 INFO - "slavename": "talos-linux64-ix-044", 12:34:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:34:09 INFO - "platform": "ubuntu64_hw", 12:34:09 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:34:09 INFO - "branch": "mozilla-central", 12:34:09 INFO - "repo_path": "mozilla-central", 12:34:09 INFO - "revision": "7083c0d30e75fc102c715887af9faec933e936f8", 12:34:09 INFO - "stage_platform": "linux64", 12:34:09 INFO - "builduid": "9575e87b407a436aaaed81bd4e774fb6", 12:34:09 INFO - "slavebuilddir": "test" 12:34:09 INFO - } 12:34:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 12:34:09 INFO - Running post-action listener: _resource_record_post_action 12:34:09 INFO - [mozharness: 2016-12-20 20:34:09.582687Z] Finished read-buildbot-config step (success) 12:34:09 INFO - [mozharness: 2016-12-20 20:34:09.582775Z] Running download-and-extract step. 12:34:09 INFO - Running pre-action listener: _resource_record_pre_action 12:34:09 INFO - Running main action method: download_and_extract 12:34:09 INFO - mkdir: /builds/slave/test/build/tests 12:34:09 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')]} 12:34:09 INFO - trying https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:34:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/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 12:34:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/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 12:34:10 INFO - Downloaded 1361 bytes. 12:34:10 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:34:10 INFO - Using the following test package requirements: 12:34:10 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:34:10 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:34:10 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:34:10 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:10 INFO - u'jsshell-linux-x86_64.zip'], 12:34:10 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:34:10 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:34:10 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:34:10 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:34:10 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:34:10 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:34:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:34:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:34:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:34:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:34:13 INFO - Expected file size: 20264693 12:34:13 INFO - Obtained file size: 20264693 12:34:17 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 12:34:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:34:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:34:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:34:17 INFO - Expected file size: 20264693 12:34:17 INFO - Obtained file size: 20264693 12:34:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 12:34:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:34:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:34:23 INFO - Expected file size: 14409734 12:34:23 INFO - Obtained file size: 14409734 12:34:23 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')]} 12:34:23 INFO - trying https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:34:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/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 12:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/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 12:34:25 INFO - Downloaded 55654627 bytes. 12:34:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:34:25 INFO - mkdir: /builds/slave/test/properties 12:34:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:34:25 INFO - Writing to file /builds/slave/test/properties/build_url 12:34:25 INFO - Contents: 12:34:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:34:25 INFO - Running post-action listener: _resource_record_post_action 12:34:25 INFO - Running post-action listener: set_extra_try_arguments 12:34:25 INFO - [mozharness: 2016-12-20 20:34:25.811624Z] Finished download-and-extract step (success) 12:34:25 INFO - [mozharness: 2016-12-20 20:34:25.811850Z] Running populate-webroot step. 12:34:25 INFO - Running pre-action listener: _resource_record_pre_action 12:34:25 INFO - Running main action method: populate_webroot 12:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:34:25 INFO - '--tppagecycles', 12:34:25 INFO - '7'], 12:34:25 INFO - 'tests': ['tsvgm']}}, 12:34:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:34:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:34:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:34:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:34:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:34:25 INFO - 'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:34:25 INFO - 'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['damp', 'tps']}, 12:34:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:34:25 INFO - 'tests': ['damp', 'tps']}, 12:34:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['dromaeo_dom']}, 12:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:34:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['basic_compositor_video']}, 12:34:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:34:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['a11yr', 12:34:25 INFO - 'ts_paint', 12:34:25 INFO - 'tpaint', 12:34:25 INFO - 'sessionrestore', 12:34:25 INFO - 'sessionrestore_no_auto_restore', 12:34:25 INFO - 'tabpaint']}, 12:34:25 INFO - 'other-e10s': {'tests': ['a11yr', 12:34:25 INFO - 'ts_paint', 12:34:25 INFO - 'tpaint', 12:34:25 INFO - 'sessionrestore', 12:34:25 INFO - 'sessionrestore_no_auto_restore', 12:34:25 INFO - 'tabpaint']}, 12:34:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:34:25 INFO - 'ts_paint', 12:34:25 INFO - 'tpaint', 12:34:25 INFO - 'sessionrestore', 12:34:25 INFO - 'sessionrestore_no_auto_restore', 12:34:25 INFO - 'tabpaint']}, 12:34:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:34:25 INFO - 'ts_paint', 12:34:25 INFO - 'tpaint', 12:34:25 INFO - 'sessionrestore', 12:34:25 INFO - 'sessionrestore_no_auto_restore', 12:34:25 INFO - 'tabpaint']}, 12:34:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['a11yr', 12:34:25 INFO - 'ts_paint', 12:34:25 INFO - 'tpaint', 12:34:25 INFO - 'sessionrestore', 12:34:25 INFO - 'sessionrestore_no_auto_restore', 12:34:25 INFO - 'tabpaint']}, 12:34:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['a11yr', 12:34:25 INFO - 'ts_paint', 12:34:25 INFO - 'tpaint', 12:34:25 INFO - 'sessionrestore', 12:34:25 INFO - 'sessionrestore_no_auto_restore', 12:34:25 INFO - 'tabpaint']}, 12:34:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['tsvgx', 12:34:25 INFO - 'tsvgr_opacity', 12:34:25 INFO - 'tart', 12:34:25 INFO - 'tscrollx', 12:34:25 INFO - 'cart', 12:34:25 INFO - 'tsvg_static']}, 12:34:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:34:25 INFO - 'tsvgr_opacity', 12:34:25 INFO - 'tart', 12:34:25 INFO - 'tscrollx', 12:34:25 INFO - 'cart', 12:34:25 INFO - 'tsvg_static']}, 12:34:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:34:25 INFO - 'talos_options': ['--disable-e10s'], 12:34:25 INFO - 'tests': ['tp5o']}, 12:34:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:34:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:34:25 INFO - 'talos_options': ['--disable-e10s', 12:34:25 INFO - '--xperf_path', 12:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:25 INFO - 'tests': ['tp5n']}, 12:34:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:34:25 INFO - 'talos_options': ['--xperf_path', 12:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:25 INFO - 'tests': ['tp5n']}}, 12:34:25 INFO - 'talos.zip': {'path': '', 12:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:34:25 INFO - Running post-action listener: _resource_record_post_action 12:34:25 INFO - [mozharness: 2016-12-20 20:34:25.828618Z] Finished populate-webroot step (success) 12:34:25 INFO - [mozharness: 2016-12-20 20:34:25.828706Z] Running create-virtualenv step. 12:34:25 INFO - Running pre-action listener: _resource_record_pre_action 12:34:25 INFO - Running main action method: create_virtualenv 12:34:25 INFO - Creating virtualenv /builds/slave/test/build/venv 12:34:25 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 12:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:34:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:34:25 INFO - Using real prefix '/usr' 12:34:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:34:26 INFO - Installing distribute.............................................................................................................................................................................................done. 12:34:28 INFO - Installing pip.................done. 12:34:28 INFO - Return code: 0 12:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:34:28 INFO - Reading from file tmpfile_stdout 12:34:28 INFO - Output received: 12:34:28 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) 12:34:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:34:28 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')]} 12:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:28 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')]} 12:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:28 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 0x25601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2670a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', '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 12:34:28 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 12:34:28 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 12:34:28 INFO - Using env: {'DISPLAY': ':0', 12:34:28 INFO - 'HOME': '/home/cltbld', 12:34:28 INFO - 'LANG': 'en_US.UTF-8', 12:34:28 INFO - 'LANGUAGE': 'en_US:en', 12:34:28 INFO - 'LOGNAME': 'cltbld', 12:34:28 INFO - 'MAIL': '/var/mail/cltbld', 12:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:28 INFO - 'MOZ_NO_REMOTE': '1', 12:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:28 INFO - 'NO_EM_RESTART': '1', 12:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:28 INFO - 'PWD': '/builds/slave/test', 12:34:28 INFO - 'SHELL': '/bin/bash', 12:34:28 INFO - 'SHLVL': '1', 12:34:28 INFO - 'TERM': 'linux', 12:34:28 INFO - 'TMOUT': '86400', 12:34:28 INFO - 'USER': 'cltbld', 12:34:28 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:28 INFO - '_': '/tools/buildbot/bin/python'} 12:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:28 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 12:34:28 INFO - Cleaning up... 12:34:28 INFO - Return code: 0 12:34:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:34:28 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')]} 12:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:28 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')]} 12:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:28 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 0x25601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2670a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', '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 12:34:28 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 12:34:28 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 12:34:28 INFO - Using env: {'DISPLAY': ':0', 12:34:28 INFO - 'HOME': '/home/cltbld', 12:34:28 INFO - 'LANG': 'en_US.UTF-8', 12:34:28 INFO - 'LANGUAGE': 'en_US:en', 12:34:28 INFO - 'LOGNAME': 'cltbld', 12:34:28 INFO - 'MAIL': '/var/mail/cltbld', 12:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:28 INFO - 'MOZ_NO_REMOTE': '1', 12:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:28 INFO - 'NO_EM_RESTART': '1', 12:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:28 INFO - 'PWD': '/builds/slave/test', 12:34:28 INFO - 'SHELL': '/bin/bash', 12:34:28 INFO - 'SHLVL': '1', 12:34:28 INFO - 'TERM': 'linux', 12:34:28 INFO - 'TMOUT': '86400', 12:34:28 INFO - 'USER': 'cltbld', 12:34:28 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:28 INFO - '_': '/tools/buildbot/bin/python'} 12:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:29 INFO - Downloading/unpacking psutil>=3.1.1 12:34:29 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 12:34:29 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 12:34:29 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 12:34:29 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 12:34:29 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 12:34:29 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 12:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:34:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:31 INFO - Installing collected packages: psutil 12:34:31 INFO - Running setup.py install for psutil 12:34:31 INFO - building 'psutil._psutil_linux' extension 12:34:31 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 12:34:31 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 12:34:31 INFO - building 'psutil._psutil_posix' extension 12:34:31 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 12:34:31 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 12:34:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:31 INFO - Successfully installed psutil 12:34:31 INFO - Cleaning up... 12:34:31 INFO - Return code: 0 12:34:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:31 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 0x25601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2670a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', '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 12:34:31 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 12:34:31 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 12:34:31 INFO - Using env: {'DISPLAY': ':0', 12:34:31 INFO - 'HOME': '/home/cltbld', 12:34:31 INFO - 'LANG': 'en_US.UTF-8', 12:34:31 INFO - 'LANGUAGE': 'en_US:en', 12:34:31 INFO - 'LOGNAME': 'cltbld', 12:34:31 INFO - 'MAIL': '/var/mail/cltbld', 12:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:31 INFO - 'MOZ_NO_REMOTE': '1', 12:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:31 INFO - 'NO_EM_RESTART': '1', 12:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:31 INFO - 'PWD': '/builds/slave/test', 12:34:31 INFO - 'SHELL': '/bin/bash', 12:34:31 INFO - 'SHLVL': '1', 12:34:31 INFO - 'TERM': 'linux', 12:34:31 INFO - 'TMOUT': '86400', 12:34:31 INFO - 'USER': 'cltbld', 12:34:31 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:31 INFO - '_': '/tools/buildbot/bin/python'} 12:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:34:31 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 12:34:31 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 12:34:31 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 12:34:31 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 12:34:31 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 12:34:31 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 12:34:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:34:33 INFO - Installing collected packages: mozsystemmonitor 12:34:33 INFO - Running setup.py install for mozsystemmonitor 12:34:34 INFO - Successfully installed mozsystemmonitor 12:34:34 INFO - Cleaning up... 12:34:34 INFO - Return code: 0 12:34:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:34:34 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')]} 12:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:34 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')]} 12:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:34 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 0x25601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2670a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', '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 12:34:34 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 12:34:34 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 12:34:34 INFO - Using env: {'DISPLAY': ':0', 12:34:34 INFO - 'HOME': '/home/cltbld', 12:34:34 INFO - 'LANG': 'en_US.UTF-8', 12:34:34 INFO - 'LANGUAGE': 'en_US:en', 12:34:34 INFO - 'LOGNAME': 'cltbld', 12:34:34 INFO - 'MAIL': '/var/mail/cltbld', 12:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:34 INFO - 'MOZ_NO_REMOTE': '1', 12:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:34 INFO - 'NO_EM_RESTART': '1', 12:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:34 INFO - 'PWD': '/builds/slave/test', 12:34:34 INFO - 'SHELL': '/bin/bash', 12:34:34 INFO - 'SHLVL': '1', 12:34:34 INFO - 'TERM': 'linux', 12:34:34 INFO - 'TMOUT': '86400', 12:34:34 INFO - 'USER': 'cltbld', 12:34:34 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:34 INFO - '_': '/tools/buildbot/bin/python'} 12:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:34 INFO - Downloading/unpacking jsonschema==2.5.1 12:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:34:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:34:36 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 12:34:36 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 12:34:36 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 12:34:36 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 12:34:36 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 12:34:36 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 12:34:36 INFO - Downloading functools32-3.2.3-2.tar.gz 12:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:34:36 INFO - warning: no files found matching '*.txt' 12:34:36 INFO - no previously-included directories found matching 'build' 12:34:36 INFO - no previously-included directories found matching 'dist' 12:34:36 INFO - no previously-included directories found matching '.git*' 12:34:36 INFO - Installing collected packages: jsonschema, functools32 12:34:36 INFO - Running setup.py install for functools32 12:34:36 INFO - warning: no files found matching '*.txt' 12:34:36 INFO - no previously-included directories found matching 'build' 12:34:36 INFO - no previously-included directories found matching 'dist' 12:34:36 INFO - no previously-included directories found matching '.git*' 12:34:36 INFO - Successfully installed jsonschema functools32 12:34:36 INFO - Cleaning up... 12:34:36 INFO - Return code: 0 12:34:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:36 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 0x25601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2670a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', '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 12:34:36 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 12:34:36 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 12:34:36 INFO - Using env: {'DISPLAY': ':0', 12:34:36 INFO - 'HOME': '/home/cltbld', 12:34:36 INFO - 'LANG': 'en_US.UTF-8', 12:34:36 INFO - 'LANGUAGE': 'en_US:en', 12:34:36 INFO - 'LOGNAME': 'cltbld', 12:34:36 INFO - 'MAIL': '/var/mail/cltbld', 12:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:36 INFO - 'MOZ_NO_REMOTE': '1', 12:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:36 INFO - 'NO_EM_RESTART': '1', 12:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:36 INFO - 'PWD': '/builds/slave/test', 12:34:36 INFO - 'SHELL': '/bin/bash', 12:34:36 INFO - 'SHLVL': '1', 12:34:36 INFO - 'TERM': 'linux', 12:34:36 INFO - 'TMOUT': '86400', 12:34:36 INFO - 'USER': 'cltbld', 12:34:36 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:36 INFO - '_': '/tools/buildbot/bin/python'} 12:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:34:37 INFO - Cleaning up... 12:34:37 INFO - Return code: 0 12:34:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:34:37 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')]} 12:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:37 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')]} 12:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:37 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 0x25601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2670a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', '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 12:34:37 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 12:34:37 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 12:34:37 INFO - Using env: {'DISPLAY': ':0', 12:34:37 INFO - 'HOME': '/home/cltbld', 12:34:37 INFO - 'LANG': 'en_US.UTF-8', 12:34:37 INFO - 'LANGUAGE': 'en_US:en', 12:34:37 INFO - 'LOGNAME': 'cltbld', 12:34:37 INFO - 'MAIL': '/var/mail/cltbld', 12:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:37 INFO - 'MOZ_NO_REMOTE': '1', 12:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:37 INFO - 'NO_EM_RESTART': '1', 12:34:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:37 INFO - 'PWD': '/builds/slave/test', 12:34:37 INFO - 'SHELL': '/bin/bash', 12:34:37 INFO - 'SHLVL': '1', 12:34:37 INFO - 'TERM': 'linux', 12:34:37 INFO - 'TMOUT': '86400', 12:34:37 INFO - 'USER': 'cltbld', 12:34:37 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:37 INFO - '_': '/tools/buildbot/bin/python'} 12:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:37 INFO - Downloading/unpacking blobuploader==1.2.4 12:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:39 INFO - Downloading blobuploader-1.2.4.tar.gz 12:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:34:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:34:39 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 12:34:39 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 12:34:39 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 12:34:39 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 12:34:39 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 12:34:39 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 12:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:34:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:34:39 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 12:34:39 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 12:34:39 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 12:34:39 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 12:34:39 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 12:34:39 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 12:34:40 INFO - Downloading docopt-0.6.1.tar.gz 12:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:34:40 INFO - Installing collected packages: blobuploader, requests, docopt 12:34:40 INFO - Running setup.py install for blobuploader 12:34:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:34:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:34:40 INFO - Running setup.py install for requests 12:34:40 INFO - Running setup.py install for docopt 12:34:40 INFO - Successfully installed blobuploader requests docopt 12:34:40 INFO - Cleaning up... 12:34:40 INFO - Return code: 0 12:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:40 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 0x25601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2670a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', '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 12:34:40 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 12:34:40 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 12:34:40 INFO - Using env: {'DISPLAY': ':0', 12:34:40 INFO - 'HOME': '/home/cltbld', 12:34:40 INFO - 'LANG': 'en_US.UTF-8', 12:34:40 INFO - 'LANGUAGE': 'en_US:en', 12:34:40 INFO - 'LOGNAME': 'cltbld', 12:34:40 INFO - 'MAIL': '/var/mail/cltbld', 12:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:40 INFO - 'MOZ_NO_REMOTE': '1', 12:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:40 INFO - 'NO_EM_RESTART': '1', 12:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:40 INFO - 'PWD': '/builds/slave/test', 12:34:40 INFO - 'SHELL': '/bin/bash', 12:34:40 INFO - 'SHLVL': '1', 12:34:40 INFO - 'TERM': 'linux', 12:34:40 INFO - 'TMOUT': '86400', 12:34:40 INFO - 'USER': 'cltbld', 12:34:40 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:40 INFO - '_': '/tools/buildbot/bin/python'} 12:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:34:40 INFO - Running setup.py (path:/tmp/pip-4LYAVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:34:40 INFO - Running setup.py (path:/tmp/pip-3XLY45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:34:41 INFO - Running setup.py (path:/tmp/pip-wB1zGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:34:41 INFO - Running setup.py (path:/tmp/pip-Ownuhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:34:41 INFO - Running setup.py (path:/tmp/pip-tFSuhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:34:41 INFO - Running setup.py (path:/tmp/pip-avMhzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:34:41 INFO - Running setup.py (path:/tmp/pip-EKsQDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:34:41 INFO - Running setup.py (path:/tmp/pip-3O2_MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:34:41 INFO - Running setup.py (path:/tmp/pip-Rvihog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:34:41 INFO - Running setup.py (path:/tmp/pip-TChr7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:34:41 INFO - Running setup.py (path:/tmp/pip-yoIC2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:34:41 INFO - Running setup.py (path:/tmp/pip-96NrNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:34:41 INFO - Running setup.py (path:/tmp/pip-RMoqnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:34:41 INFO - Running setup.py (path:/tmp/pip-Ei8_G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:41 INFO - Running setup.py (path:/tmp/pip-ujz23m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:34:42 INFO - Running setup.py (path:/tmp/pip-mtZ4pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:34:42 INFO - Running setup.py (path:/tmp/pip-2TI3kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:34:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:34:42 INFO - Running setup.py install for manifestparser 12:34:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:34:42 INFO - Running setup.py install for mozcrash 12:34:42 INFO - Running setup.py install for mozdebug 12:34:42 INFO - Running setup.py install for mozdevice 12:34:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:34:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:34:42 INFO - Running setup.py install for mozfile 12:34:42 INFO - Running setup.py install for mozhttpd 12:34:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:34:42 INFO - Running setup.py install for mozinfo 12:34:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:34:42 INFO - Running setup.py install for mozInstall 12:34:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:34:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:34:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:34:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:34:42 INFO - Running setup.py install for mozleak 12:34:43 INFO - Running setup.py install for mozlog 12:34:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:34:43 INFO - Running setup.py install for moznetwork 12:34:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:34:43 INFO - Running setup.py install for mozprocess 12:34:43 INFO - Running setup.py install for mozprofile 12:34:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:34:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:34:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:34:43 INFO - Running setup.py install for mozrunner 12:34:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:34:43 INFO - Running setup.py install for mozscreenshot 12:34:43 INFO - Running setup.py install for moztest 12:34:43 INFO - Running setup.py install for mozversion 12:34:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:34:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:34:43 INFO - Cleaning up... 12:34:43 INFO - Return code: 0 12:34:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:43 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 0x25601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2670a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', '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 12:34:43 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 12:34:43 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 12:34:43 INFO - Using env: {'DISPLAY': ':0', 12:34:43 INFO - 'HOME': '/home/cltbld', 12:34:43 INFO - 'LANG': 'en_US.UTF-8', 12:34:43 INFO - 'LANGUAGE': 'en_US:en', 12:34:43 INFO - 'LOGNAME': 'cltbld', 12:34:43 INFO - 'MAIL': '/var/mail/cltbld', 12:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:43 INFO - 'MOZ_NO_REMOTE': '1', 12:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:43 INFO - 'NO_EM_RESTART': '1', 12:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:43 INFO - 'PWD': '/builds/slave/test', 12:34:43 INFO - 'SHELL': '/bin/bash', 12:34:43 INFO - 'SHLVL': '1', 12:34:43 INFO - 'TERM': 'linux', 12:34:43 INFO - 'TMOUT': '86400', 12:34:43 INFO - 'USER': 'cltbld', 12:34:43 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:43 INFO - '_': '/tools/buildbot/bin/python'} 12:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:34:44 INFO - Running setup.py (path:/tmp/pip-htr24z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:34:44 INFO - Running setup.py (path:/tmp/pip-rO2W5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:34:44 INFO - Running setup.py (path:/tmp/pip-bxx89H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:34:44 INFO - Running setup.py (path:/tmp/pip-eHw_G3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:34:44 INFO - Running setup.py (path:/tmp/pip-IYNwTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:34:44 INFO - Running setup.py (path:/tmp/pip-hSbPa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:34:44 INFO - Running setup.py (path:/tmp/pip-WpwCNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:34:44 INFO - Running setup.py (path:/tmp/pip-VAjhRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:34:44 INFO - Running setup.py (path:/tmp/pip-9UrIPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:34:44 INFO - Running setup.py (path:/tmp/pip-yA0X_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:34:44 INFO - Running setup.py (path:/tmp/pip-txGMDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:34:44 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)) 12:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:34:44 INFO - Running setup.py (path:/tmp/pip-4RTouZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:34:45 INFO - Running setup.py (path:/tmp/pip-8QmR8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:34:45 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)) 12:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:34:45 INFO - Running setup.py (path:/tmp/pip-SIE4ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:34:45 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)) 12:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:45 INFO - Running setup.py (path:/tmp/pip-XZukSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:45 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)) 12:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:34:45 INFO - Running setup.py (path:/tmp/pip-Mb6dZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:34:45 INFO - Running setup.py (path:/tmp/pip-7lU8Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:34:45 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)) 12:34:45 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)) 12:34:45 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)) 12:34:45 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)) 12:34:45 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)) 12:34:45 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)) 12:34:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:47 INFO - Downloading blessings-1.6.tar.gz 12:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:34:47 INFO - Installing collected packages: blessings 12:34:47 INFO - Running setup.py install for blessings 12:34:47 INFO - Successfully installed blessings 12:34:47 INFO - Cleaning up... 12:34:47 INFO - Return code: 0 12:34:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:34:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:34:47 INFO - Reading from file tmpfile_stdout 12:34:47 INFO - Current package versions: 12:34:47 INFO - argparse == 1.2.1 12:34:47 INFO - blessings == 1.6 12:34:47 INFO - blobuploader == 1.2.4 12:34:47 INFO - docopt == 0.6.1 12:34:47 INFO - functools32 == 3.2.3-2 12:34:47 INFO - jsonschema == 2.5.1 12:34:47 INFO - manifestparser == 1.1 12:34:47 INFO - mozInstall == 1.12 12:34:47 INFO - mozcrash == 1.0 12:34:47 INFO - mozdebug == 0.1 12:34:47 INFO - mozdevice == 0.49 12:34:47 INFO - mozfile == 1.2 12:34:47 INFO - mozhttpd == 0.7 12:34:47 INFO - mozinfo == 0.9 12:34:47 INFO - mozleak == 0.1 12:34:47 INFO - mozlog == 3.4 12:34:47 INFO - moznetwork == 0.27 12:34:47 INFO - mozprocess == 0.23 12:34:47 INFO - mozprofile == 0.28 12:34:47 INFO - mozrunner == 6.13 12:34:47 INFO - mozscreenshot == 0.1 12:34:47 INFO - mozsystemmonitor == 0.3 12:34:47 INFO - moztest == 0.7 12:34:47 INFO - mozversion == 1.4 12:34:47 INFO - psutil == 3.1.1 12:34:47 INFO - requests == 1.2.3 12:34:47 INFO - wsgiref == 0.1.2 12:34:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34:47 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')]} 12:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:47 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')]} 12:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:47 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 0x25601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2670a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', '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 12:34:47 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 12:34:47 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 12:34:47 INFO - Using env: {'DISPLAY': ':0', 12:34:47 INFO - 'HOME': '/home/cltbld', 12:34:47 INFO - 'LANG': 'en_US.UTF-8', 12:34:47 INFO - 'LANGUAGE': 'en_US:en', 12:34:47 INFO - 'LOGNAME': 'cltbld', 12:34:47 INFO - 'MAIL': '/var/mail/cltbld', 12:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:47 INFO - 'MOZ_NO_REMOTE': '1', 12:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:47 INFO - 'NO_EM_RESTART': '1', 12:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:47 INFO - 'PWD': '/builds/slave/test', 12:34:47 INFO - 'SHELL': '/bin/bash', 12:34:47 INFO - 'SHLVL': '1', 12:34:47 INFO - 'TERM': 'linux', 12:34:47 INFO - 'TMOUT': '86400', 12:34:47 INFO - 'USER': 'cltbld', 12:34:47 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:47 INFO - '_': '/tools/buildbot/bin/python'} 12:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:48 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)) 12:34:48 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)) 12:34:48 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)) 12:34:48 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)) 12:34:48 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)) 12:34:48 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)) 12:34:48 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)) 12:34:48 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)) 12:34:48 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)) 12:34:48 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)) 12:34:48 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)) 12:34:48 INFO - Cleaning up... 12:34:48 INFO - Return code: 0 12:34:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:34: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')]} 12:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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')]} 12:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2670a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', '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 12:34: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', 'jsonschema'] in /builds/slave/test/build 12:34: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 jsonschema 12:34:48 INFO - Using env: {'DISPLAY': ':0', 12:34:48 INFO - 'HOME': '/home/cltbld', 12:34:48 INFO - 'LANG': 'en_US.UTF-8', 12:34:48 INFO - 'LANGUAGE': 'en_US:en', 12:34:48 INFO - 'LOGNAME': 'cltbld', 12:34:48 INFO - 'MAIL': '/var/mail/cltbld', 12:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:48 INFO - 'MOZ_NO_REMOTE': '1', 12:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:48 INFO - 'NO_EM_RESTART': '1', 12:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:48 INFO - 'PWD': '/builds/slave/test', 12:34:48 INFO - 'SHELL': '/bin/bash', 12:34:48 INFO - 'SHLVL': '1', 12:34:48 INFO - 'TERM': 'linux', 12:34:48 INFO - 'TMOUT': '86400', 12:34:48 INFO - 'USER': 'cltbld', 12:34:48 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:48 INFO - '_': '/tools/buildbot/bin/python'} 12:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:34:48 INFO - Cleaning up... 12:34:48 INFO - Return code: 0 12:34:48 INFO - Running post-action listener: _resource_record_post_action 12:34:48 INFO - Running post-action listener: _start_resource_monitoring 12:34:48 INFO - Starting resource monitoring. 12:34:48 INFO - [mozharness: 2016-12-20 20:34:48.417750Z] Finished create-virtualenv step (success) 12:34:48 INFO - [mozharness: 2016-12-20 20:34:48.418342Z] Running install step. 12:34:48 INFO - Running pre-action listener: _resource_record_pre_action 12:34:48 INFO - Running main action method: install 12:34:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:34:48 INFO - Reading from file tmpfile_stdout 12:34:48 INFO - Detecting whether we're running mozinstall >=1.0... 12:34:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:34:48 INFO - Reading from file tmpfile_stdout 12:34:48 INFO - Output received: 12:34:48 INFO - Usage: mozinstall [options] installer 12:34:48 INFO - Options: 12:34:48 INFO - -h, --help show this help message and exit 12:34:48 INFO - -d DEST, --destination=DEST 12:34:48 INFO - Directory to install application into. [default: 12:34:48 INFO - "/builds/slave/test"] 12:34:48 INFO - --app=APP Application being installed. [default: firefox] 12:34:48 INFO - mkdir: /builds/slave/test/build/application 12:34:48 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'] 12:34:48 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 12:35:04 INFO - Reading from file tmpfile_stdout 12:35:04 INFO - Output received: 12:35:04 INFO - /builds/slave/test/build/application/firefox/firefox 12:35:04 INFO - Running post-action listener: _resource_record_post_action 12:35:04 INFO - [mozharness: 2016-12-20 20:35:04.756017Z] Finished install step (success) 12:35:04 INFO - [mozharness: 2016-12-20 20:35:04.756262Z] Running run-tests step. 12:35:04 INFO - Running pre-action listener: _resource_record_pre_action 12:35:04 INFO - Running main action method: run_tests 12:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:35:04 INFO - Python 2.7.3 12:35:04 INFO - Return code: 0 12:35:04 INFO - grabbing minidump binary from tooltool 12:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295b850>, '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 0x28d06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:35:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:35:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:35:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:35:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:35:04 INFO - Return code: 0 12:35:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:35:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:35:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:35:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:35:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 12:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 12:35:04 INFO - Using env: {'DISPLAY': ':0', 12:35:04 INFO - 'HOME': '/home/cltbld', 12:35:04 INFO - 'LANG': 'en_US.UTF-8', 12:35:04 INFO - 'LANGUAGE': 'en_US:en', 12:35:04 INFO - 'LOGNAME': 'cltbld', 12:35:04 INFO - 'MAIL': '/var/mail/cltbld', 12:35:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:35:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:04 INFO - 'MOZ_NO_REMOTE': '1', 12:35:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:04 INFO - 'NO_EM_RESTART': '1', 12:35:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:04 INFO - 'PWD': '/builds/slave/test', 12:35:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:35:04 INFO - 'SHELL': '/bin/bash', 12:35:04 INFO - 'SHLVL': '1', 12:35:04 INFO - 'TERM': 'linux', 12:35:04 INFO - 'TMOUT': '86400', 12:35:04 INFO - 'USER': 'cltbld', 12:35:04 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169', 12:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:04 INFO - '_': '/tools/buildbot/bin/python'} 12:35:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 12:35:05 INFO - mozversion application_buildid: 20161220114253 12:35:05 INFO - mozversion application_changeset: 7083c0d30e75fc102c715887af9faec933e936f8 12:35:05 INFO - mozversion application_display_name: Nightly 12:35:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:35:05 INFO - mozversion application_name: Firefox 12:35:05 INFO - mozversion application_remotingname: firefox 12:35:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:35:05 INFO - mozversion application_vendor: Mozilla 12:35:05 INFO - mozversion application_version: 53.0a1 12:35:05 INFO - mozversion platform_buildid: 20161220114253 12:35:05 INFO - mozversion platform_changeset: 7083c0d30e75fc102c715887af9faec933e936f8 12:35:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:35:05 INFO - mozversion platform_version: 53.0a1 12:35:05 INFO - using testdate: 1482266105 12:35:05 INFO - actual date: 1482266105 12:35:05 INFO - starting webserver on 'localhost:39065' 12:35:05 INFO - SUITE-START | Running 2 tests 12:35:05 INFO - TEST-START | dromaeo_css 12:35:05 INFO - operating with platform_type : linux_ 12:35:05 INFO - Initialising browser for dromaeo_css test... 12:35:05 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjihFYD/profile http://localhost:39065/getInfo.html) 12:35:08 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 12:35:08 INFO - PROCESS | 1642 | colorDepth:24 12:35:08 INFO - PROCESS | 1642 | Browser inner width/height: 1024/697 12:35:08 INFO - PROCESS | 1642 | __metrics 12:35:09 INFO - PROCESS | 1642 | 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" 12:35:09 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:09 INFO - PROCESS | 1642 | console.error: PushService: 12:35:09 INFO - PROCESS | 1642 | stateChangeProcessEnqueue: Error transitioning state 12:35:09 INFO - PROCESS | 1642 | UnknownError 12:35:10 INFO - TEST-INFO | 1642: exit 0 12:35:10 INFO - Browser initialized. 12:35:10 INFO - Running cycle 1/1 for dromaeo_css test... 12:35:10 INFO - TEST-INFO | started process 1724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjihFYD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:22 INFO - PROCESS | 1724 | RSS: Main: 154001408 12:35:22 INFO - PROCESS | 1724 | 12:36:13 INFO - PROCESS | 1724 | 1482266173904 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:38:27 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39065/tests/dromaeo/cssquery-ext.html) 12:38:29 INFO - PROCESS | 1724 | RSS: Main: 289079296 12:38:29 INFO - PROCESS | 1724 | 12:41:32 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-ext.html (next: http://localhost:39065/tests/dromaeo/cssquery-jquery.html) 12:41:32 INFO - PROCESS | 1724 | RSS: Main: 255442944 12:41:32 INFO - PROCESS | 1724 | 12:44:35 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39065/tests/dromaeo/cssquery-mootools.html) 12:44:35 INFO - PROCESS | 1724 | RSS: Main: 192323584 12:44:35 INFO - PROCESS | 1724 | 12:47:38 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39065/tests/dromaeo/cssquery-prototype.html) 12:47:38 INFO - PROCESS | 1724 | RSS: Main: 187453440 12:47:38 INFO - PROCESS | 1724 | 12:50:41 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39065/tests/dromaeo/cssquery-yui.html) 12:50:42 INFO - PROCESS | 1724 | RSS: Main: 193069056 12:50:42 INFO - PROCESS | 1724 | 12:53:45 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:39065/tests/dromaeo/cssquery-yui.html (next: http://localhost:39065/tests/dromaeo/cssquery-dojo.html) 12:53:45 INFO - PROCESS | 1724 | RSS: Main: 275234816 12:53:45 INFO - PROCESS | 1724 | 12:53:45 INFO - PROCESS | 1724 | __start_tp_report 12:53:45 INFO - PROCESS | 1724 | _x_x_mozilla_page_load 12:53:45 INFO - PROCESS | 1724 | _x_x_mozilla_page_load_details 12:53:45 INFO - PROCESS | 1724 | |i|pagename|runs| 12:53:45 INFO - PROCESS | 1724 | |0;dojo.html;2600.1289567994722;2637.1429285482222;2658.029819116023;2660.747229013243;2669.5728683410657;4687.671862969585;4707.435107787066;4756.90486190276;4791.305260737191;4836.540528649777;4744.501827308135;4756.9286460703115;4770.379850619414;4793.5925446337105;4847.321375007502;4344.435223420966;4394.494633117192;4412.029353542232;4432.401625780527;4463.263561512346;4351.912961740763;4370.344448332744;4383.561643835623;4418.955810441903;4459.37568740375;4453.465584129909;4467.084247729208;4473.1501014807245;4481.887952801189;4487.39420178275;4290.721103128287;4321.24378233811;4331.740095594275;4415.381846541487;4483.193025255453;4301.677374196916;4316.611504964537;4330.307150855848;4359.782010899442;4392.648588112943;4728.787204575802;4743.0988112258565;4759.095771803346;4759.524047595248;4789.87437952081;5051.242313652945;5085.644004919657;5090.592752579785;5091.23631455281;5141.383034035902;4972.353594032753;5002.24966255061;5060.974695126501;5147.691138531663;5152.098382782998;4746.5253474652945;4782.378290822206;4785.712857228507;4785.736784476818;4847.854564363075;5266.2890509781455;5271.42014378418;5275.60432967529;5275.762590683352;5278.9208161877605;5034.874128146826;5043.0922433961505;5045.84862454127;5047.116754567936;5083.796648134034;4939.382577177853;4953.23224900141;5002.274670172805;5071.7971281149075;5098.566621837112;5103.923441148386;5115.18157094863;5138.820141295037;5155;5157.58739300855;5084.7966081356335;5091.0836049511445;5092.592592592584;5094.133997220481;5141.074606570854;4239.766812825324;4250.277452833026;4388.780560971939;4396.846110386121;4436.578525040116;3752.3620984432714;3770.3967365221984;3771.849126034928;3785.488958990556;3834.827432765532;4380.62764665007;4388.451443569554;4389.473263208435;4389.6927215095275;4426.933595996063;5132.692038477629;5133.076046311625;5134.743262836843;5136.4606716295;5189.169732842803;4239.554846741109;4261.019965407973;4285.271503844354;4300.333448315516;4367.694261401735;4559.042601053816;4563.452385713736;4592.885177870513;4601.148787474328;4620.214563524209;4702.811887524529;4704.6236301096515;4708.788104535236;4715.3869996900185;4716.504766999416;4962.900741985068;5009.524095210949;5015.147424937696;5019.121653710659;5052.9494705052475;4763.7618119094595;4782.402199725035;4784.473707892199;4813.278008298783;4853.563179313879;5065.518775716301;5102.948970510396;5103.744812759422;5104.489551044866;5163.612729045261;4955.677880937727;5156.7421628917655;5189.091908915849;5199.324087868553;5202.895942081062;4870.0746858096845;4915.21356582945;4947.554720075211;4970.726610036482;5000.399952005782;4959.305697202467;4966.652334336562;4998.050370429607;5003.624728145331;5007.899842003212;4891.315215869852;4898.363212782316;4900.460949295646;4915.483874193301;4945.1346014448045;4847.2729090636685;4933.038057578881;4943.480934501826;4951.653384263067;4998.125328067501;4825.155597770447;4860.902781944271;4871.439784424837;4876.853694389174;4884.706917584814 12:53:45 INFO - PROCESS | 1724 | |1;ext.html;504.8586395809174;513.1276829390035;524.0828550037436;527.1907621800536;530.1596968804445;27250.727492725066;28039.158825235223;37001;38082;38472.422913656315;38561;38914.41628375577;38986.8050659747;39013.21973560527;39040.80479597605;7489.812754681149;7662.731804386847;7663.348615367672;7665.961670191641;7669;7146.785596432115;7287.344139027487;9474.905250947471;9702.272329575275;9719.514024298793;9906.257030722689;9965;9973;9974.750631234205;9987.051230133126;9850.950745246264;9907.306488545804;9915.107640312406;9916.553755081039;9930.602775888956;9700.563474643657;9730.810567622299;9768.316217864753;9771.462569558671;9778.55996480153;36058.819705901566;36412.45381319282;36427.45358819593;36434.45348319777;36452;3114.7352475039647;3128.8279144647036;3209.6950789674943;3313.701766840996;3588.7129029677562;24545.754542454524;24651;25123.24630261095;25171.37071573207;28665.856670716723;3391.86432542698;3443.793372397639;3484.4773284007347;3508.0528257370365;3546.131197856516;228544;228820;228863;228914;229904.85047574822;50297.49702502928;50530.242046369334;50640.214788187004;50655;50781.74609127005;53277.54114423984;53462;53500.197497037574;53563.464365355845;53582.196267056024;13287.402066907012;13475.797863032063;13480.258585777876;13483.797743033861;13485.730285394236;8548.957255213683;8682.565871706516;10527.684169474927;10632.840507392395;10653.094486968539;13812.447502100005;14552.85447145515;15384.384624615113;15457;16169.838301617068;5793.420657934257;5944.524438044946;5964.224650795456;6035.909461358083;6100.511959043266;770.6378002338892;871.13322244366;890.0565400675305;955.9904400956041;1001.8547310639916;26274.21177364682;27325.180244592695;27468.808103163738;27555.31111722183;27848.303792404946;887.40100432208;897.4929165021741;901.4906577783531;905.7101727447154;911.6490151291667;14023.941617450946;14525.854741452451;14761.40954361835;14946.925265373604;14974.326155323037;331322;333984;334022;334627;335118;47639;47801.28298075531;47803.043939121715;47821.76089119532;47914.760426197645;1030.3199888073834;1094.6168840905618;1123.662901129658;1173.6713720158368;1184.5084290019718;26857;28035.299117522227;28297;29034.41931161407;29059.12822615325;40612.79693601513;41119.38320925129;41275;41277;41315;266754;267878;267882;268132;326922;21306.680399793706;21587.2444464443;21737;21773;21806.781932180475;33013.50479742758;33200.66799331976;33470.832645836614;34261.82869085639;34609;28828.711712882603;29096.596796046593;29437.705622943497;29444.51342156819;29947.251318717208;28967.5654865173;29679.25801854971;29697.554536681535;29944.850275748482;30265.546016809327;29069.85465072661;29071.418571628026;29149.417011659225;29295;30417.543736843523;24877.626835597843;26193;29322.853385732935;29333.41333173367;29735.25661858471;22601.434964126027;22689.659655105515;22897.771022289562;23137.652935206323;23310.88344558266 12:53:45 INFO - PROCESS | 1724 | |2;jquery.html;339.5247648965248;342.32732680283254;356.87866125517326;358.5303252738912;376.28130271182033;12331.260124392531;15361.30874110665;15374.692506149884;15938.52184434466;16842.410515631957;16520.173991300417;16614.335426582922;16776.328946842143;16925.06912119833;17060.402885898995;4862.97568512157;4866.805327786893;4979.427365852937;5033.949660503385;5090.490950904898;3759.248150369923;3957.663598594123;4948.233023881304;4953.1332016896895;4991.575716064139;5583.664980101186;5845.7953971611005;5858.589898707092;5940.6435613863305;5944.851378715523;5647.322321321468;5715.685637289947;5849.03490923997;5940.584159108864;5967.552433567478;5095.414027386861;5099.59203263738;5120.590352771769;5122.564582010534;5124.128898087334;18582.163802628915;19260.22959081635;19424.028798560015;19461.416157515156;19488.80511194884;1936.8741031832885;1962.4856829777548;2112.5774845031056;2453.178185307924;2505.3736565858535;12043.578474753342;12522.624321270285;12781.338426004653;13066.150700204456;13082.86917130826;1690.2647348403484;1702.3871406293724;1723.7414387841798;1726.7496213049037;1801.5135913303334;58868.41131588715;59828;60781.39218607802;60981;62705.68647156735;8565.400421970402;8783.604737786687;8941.736266262767;9129.954350228207;9230.215431688248;12336.938315308365;12349.814752778715;12351.567695130627;12368.134230603951;12376.88608025282;6576.243731970884;6713.932860671429;6882.174139103339;6886.10480637514;6905.516613837083;6427.100205971168;6439.361760605243;6562.573432726857;6571.868562628721;6669.399754022064;5733.397993210736;5777.277840269966;5791;5879.941200588025;6009.729562169713;1579.9447019354268;1643.3755173034172;1644.7203975324223;1660.4603503861294;1678.9296325098135;781.9491733037335;786.4691333349966;814.6171299489231;840.7388916625063;867.9088695686988;15705.136217508147;16226.350945962029;16679.249433775265;16872.409465668887;17115;831.7629475599425;836.5399030533182;836.8870202522703;881.1496905486237;897.8877640294963;9327.766805829773;9490.478023708762;9692.369995950241;9888.851667224853;9919.738406658767;313784;317633;318340.47382182145;319440;319643;61438;61616.38383616106;61674.38325616776;62500.68749656223;63249.36750632435;913.7624217703445;914.6570036236411;937.3391758810022;938.2822141062093;944.960543402252;14614.853851461774;14615.707685846011;14914.328855201325;14988.1756503389;15518;31279.68720312859;31622.367552648357;32111.67888321087;32889.83555082305;32942.50586241256;40744.3888341681;40910.59089409068;41156.38265426081;41326.38010429786;42835.571644284406;4481.955180448153;6785.660716964033;7032.859342813217;7408;7526.209747976383;11236.381998990135;11489.597864074718;11554.884451155382;11593.536258549564;11795;9625.759356016155;9704.320697551104;10101.343412678152;10244.897551024394;10427.530761115617;9849.556769945513;10116.645917392856;10152.746181345525;10207.438590877573;10361.274710770174;10197.490125493843;10382.273240873066;10395.688129356131;10432.165426765689;10464.686059418229;7201.783946481614;7250.564966102051;7381.409487241115;7478.850422991401;7639.083310002835;10198.745031374276;10439.686809395731;10455.215858810467;10522.473876306001;10666.946665266623 12:53:45 INFO - PROCESS | 1724 | |3;mootools.html;1224.3021477757682;1319.4458327502448;1320.4124164746688;1386.4869998100698;1644.5395289318994;6106.358832322609;6847.075644787952;7133.393661538776;7134.072570565819;7278.344948954593;7073.858522829541;7142.392896603782;7146.428285737142;7162.964185179067;7170.06789117414;1812.1482903035553;1888.1975160556776;2071.5960387724363;2109.166879082761;2109.3882773995524;2066.5350296183387;2136.2629892687078;2142.657174852024;2152.924647637333;2153.881536515491;2085.7184280122215;2103.3059090500096;2113.9048742806613;2115.481706981784;2127.680847872816;2086.6139764143604;2104.8000439958178;2108.1988844239245;2118.248021952208;2118.5127420693175;2027.979720202794;2042.816146546818;2062.5565503416688;2062.6287268291703;2066.4523901166203;7093.3970612498;7221.24176961422;7238.71045158193;7241.493095483265;7243.348098671092;4227.154569086164;4356.390105385249;4356.586124318184;4361.847335343247;4374.6500279977845;2770.2381844992788;2941.5440606705993;2997.4155039767256;2999.895003674861;3021.5165573508134;891.5185799668171;923.630547780893;944.9055094490565;948.8054948735493;948.8292107420662;9134.680286189952;9154.267658587298;9180.265578753684;9205.585748641328;9209.263258939269;3678.6873115785456;3860.092878173627;3889.2999260132883;3891.8832435026993;4070.4097905804083;8131.634076466573;8132.390070744717;8141.470804397695;8150.959245203855;8158.021037475541;4436.866893993185;4486.64106871456;4487.6185524230805;4511.774411279423;4514.503404625489;3529.8411571479346;3623;4075.144219713893;4089.6114869087387;4096.119334343071;3306.8842590509216;3348.2131699050706;3460.636633153533;3465.7747246428903;3493.7729047612333;1125.1842414249604;1126.442411006557;1156.4275683536534;1158.8319693644544;1175.6884425627215;792.5918152151646;793.4763056382875;805.6414895371504;822.3585603229491;826.4669288309127;4837.05677392905;4860.36815214027;4917.582005529499;5003.649744517848;5118.078745825787;398.63126607887585;412.6039002557578;415.43085972218256;416.7707760731646;420.6340483779132;3380.4591265397416;3450.46517789743;3472.6700963408434;3481.721462283011;3597.784132952031;8089.31240844523;8302.335813135056;8398.328133749286;8468.153184681483;8475.660973560989;8334.6666133354;8335.124811894784;8342.082370939192;8346.666133354598;8360.331173506105;6373.872522549523;6467.223933128054;6551.967240163864;6552.312007239267;6614.735410583523;4614.861554153381;4639.234526303258;4696.178168820375;4698.801805539566;4708.458527269408;7535.434842386952;7538.660760265691;7658.73194438192;7717.151113377412;7751.108622508484;7730.845383092419;7821.530708157528;7825.686972521035;7837.451378403457;7840.764777056697;5614.803481878278;5795.449432303924;6030.668313242638;6111.266648002091;6121.693915304128;6576.736930522917;6745.696443660146;6769.492288078315;6893.482988775761;6899.931000689929;6122.510199183966;6248.656323902229;6267.62394256346;6388.840278993062;6393.1688880445245;6093.390660933871;6120.540959427972;6128.417800308964;6132.018876979841;6137.938620613737;5806.68063256525;5913.231279933581;5916.083007133901;5916.763329466773;5917.615355001911;4432.911341773211;4520.841770538015;4541.069080838486;4621.69958952667;4627.67606267558;4276.87169384919;4302.376155457504;4334.696571239983;4393.406890069799;4399.670024748093 12:53:45 INFO - PROCESS | 1724 | |4;prototype.html;309.31178128663726;318.82145998240986;321.88894831283216;333.89983005098463;334.29463831315906;4759.595434388077;4824.997625985221;4831.830885918994;4845.4427740809815;4872.951270487294;4779.784909679064;4787.688800227983;4793.832215872445;4797.856064318076;4801.247544646197;3556.8932932012017;3628.4375921732044;3643.6902863256655;3662.8717994870185;3693.3536631089587;3688.17016171362;3710.202306504101;3736.009957361288;3743.3262012837677;3780.7731536107785;3712.981435092821;3715.5541335039834;3759.9436008459893;3760.7743535387963;3767.3595488766973;3446.6041253292456;3725.1245957200035;3725.640141348388;3734.1411475360683;3735.4210097434943;3115.2367669921014;3118.3451475190236;3123.8281894495794;3128.7966282191815;3130.685112252859;4576.313552967048;4603.49361570227;4619.884502887421;4629.583337499607;4634.675572709912;4116.835326586933;4123.8969025774295;4124.52567954686;4124.752514849089;4128.545859955402;4766.903612169221;4935.333729946447;4967.627427942919;4996.650234483587;5007.32401125847;3402.2515046689687;3405.1316914186973;3410.4884267360094;3416.79499230047;3420.110771199506;5184.792608295664;5199.948000519984;5208.66143700662;5243.161094224905;5256.395514515803;3372.173817414749;3468.5837699476224;3468.930621387558;3469.8785542505893;3473.4963430302464;3506.982465087658;3511.894643160709;3516.261585067113;3523.823808809549;3531.805750683686;4047.797610119482;4054.270231358325;4076.6534844537955;4095.4675892133832;4095.5904409558807;4941.678790878654;4945.887175385509;4957.975210123926;4962.5533701967;4971.825986090469;1146.507001989136;1170.2042611024415;1174.1956759619688;1185.5554167187304;1187.1689817127872;772.2432016623741;781.9061712594525;788.5465857132172;790.3005839831791;792.5126047480758;4248.383984322256;4282.336237883133;4301.763403012865;4355.324924636687;4472.463304403493;5148.6910785353;5178.844634660966;5195.558377537876;5207.895842083137;5214.558391461617;4485.25993211123;4494.258447356215;4502.5591810620945;4509.571590698878;4511.390962220124;2607.2178346495975;2697.352635367537;2698.7840972722133;2699.9460010799676;2717.4293398386167;4689.50760170184;4727.810887564528;4728.503507131771;4730.739809310521;4759.714417134983;5161.993411284839;5171.793128274902;5177.767000484987;5179.8446046618665;5188.455212202664;4545.431821022372;4653.325267836145;4669.182892993645;4704.858854234379;4752.7623618818925;4999.77501012448;5038.622103342191;5103.489651034867;5105.157648987875;5105.5193993741395;4972.825951091694;4977.900441991067;4989.900201995867;5002.874928126826;5032.547070763502;4461.643068554573;4707.7175369477945;4708.364370809897;4741.928871067006;4745.881352966204;3364.8149351785887;3405.863765449354;3429.622741498383;3430.125318043883;3436.2096717754557;5121.590272778094;5126.333576635014;5127.359080114986;5127.79488820443;5134.820281290137;4629.259318509023;4894.902101958012;4896.48209055194;4904.435989861069;4961.5286547777905;4904.607631389552;4907.730074845775;4913.238448040559;4916.237983112624;4923.827666031815;4846.781894814671;4854.56790246871;4857.222844344888;4859.31969524274;4864.343313652753;4656.790444429941;4921.557059864486;4928.619986403813;4964.975175124246;4977.651564390458;4831.73425461603;4831.73425461603;4845.709257444564;4850.490698476609;4855.95144048555 12:53:45 INFO - PROCESS | 1724 | |5;yui.html;634.3434545245672;638.961662300262;660.4782222044585;677.7018112030703;715.7566427414678;14173.716525669493;14719.411223551046;14756.409743610242;14779;14784;14110.365033573487;14759.77860332096;14828.6292842679;14894.702105957875;14901.850981490183;619.7118339971912;638.5179189711761;761.4479502360799;775.9573223472706;804.2078552625688;774.6165648004246;792.4056957282038;792.9722459713911;793.1830214878655;793.2860425616933;793.1196372027046;793.3018943329862;793.9563324017176;793.9801504962393;797.872340425532;646.8350570604466;664.7640087768821;788.1055002572065;792.3661071143063;797.1430711984582;602.8794241151787;603.065248864263;603.5171862509975;603.704184949376;604.5737754882797;13061.412236449383;13100.803487947689;13108.541201058013;13111.86888131116;13123.737525249442;12618.242905425612;12647.747045059139;12651.177673451288;12911.548095816695;12952.287624180666;11560.884391156065;11584.247023943417;11698.181127321091;11817.527298908033;12058.457369418396;3130.5773720547663;3196.2329041030216;3237.2554312508255;3317.7511686623598;3346.9959012296213;45833;59089.70455147697;63113.36886631121;63661.36338636647;65320.3467965319;9425.340226184102;10025.298229123891;10155.543000564992;10224.6421375253;10410.739731506774;18228.635427291647;18399.356022539414;18491.907540462213;18615.720764188547;18677.906610467133;6393.584417012879;6435.388638079375;6546.312637173123;6562.639054852029;6688.197416309977;3384.526166336715;3471.1842716961496;3478.756487045933;3485.041613556242;3506.0708912138302;2815.9859200703863;2888.2634928093203;2907.433050555164;2908.578256152846;2914.621099257083;464.5447461487693;464.8256903661127;472.06295503425673;477.01020382706025;480.3011618095662;557.8438037349549;593.4925638578953;613.1109890658563;615.6367743031633;622.0343713864168;7752.651130699132;7851.725189618336;7925.167857375008;8415.200555947175;8454.704085356983;480.7139751847645;518.5592246590444;548.3556820735699;551.9586031047687;572.0561074227475;3900.5124359455067;4083.652889504366;4308.9569104309185;4403.911921761547;4439.66702497314;63371;63683.681581592726;64131.83143095684;64242.35757642457;64970.675146623966;57070.71464642733;58169;58567.41432585705;59588;60394;50209.49790502121;51861.48138518717;52990.47009529932;53494.732526337895;53866.730666347205;8177.386695997705;8515.957420212859;8546.572671366532;8571.828563428571;8644.91355086441;35341.82329088338;35345.646543535266;35455;35986;37219;44680;45505.317420239386;49096.01807963749;49278;51466.74266628643;11007.174461915549;11036.558537658724;11062.778744425228;11209.271397359145;11562.653120406401;12539.435725392197;12553.93723031379;12699.492020319083;12805.743885122432;13001.544945926848;11994.460249288977;12182.512699491921;12221.572244971383;12309.69225769327;12942.223466592035;11601;11734.530618775154;12075.335856527976;12083.697907552381;12212.511499540275;11888;11979.760404791681;12090.153689241668;12477.438515266653;12661.87338126607;8829.69096081634;9234.722958311262;9530.094641009093;9671.758206044906;10261.846072308772;8654.740357789276;9619.837179774553;10006.070316154157;10012.053113388778;10028.298461737582 12:53:45 INFO - PROCESS | 1724 | __end_tp_report 12:53:45 INFO - PROCESS | 1724 | __start_cc_report 12:53:45 INFO - PROCESS | 1724 | _x_x_mozilla_cycle_collect,1559 12:53:45 INFO - PROCESS | 1724 | __end_cc_report 12:53:45 INFO - PROCESS | 1724 | __startTimestamp1482267225680__endTimestamp 12:53:45 INFO - PROCESS | 1724 | 12:53:45 INFO - PROCESS | 1724 | ------- Summary: start ------- 12:53:45 INFO - PROCESS | 1724 | Number of tests: 6 12:53:45 INFO - PROCESS | 1724 | 12:53:45 INFO - PROCESS | 1724 | [#0] dojo.html Cycles:165 Average:4709.05 Median:4836.54 stddev:497.73 (10.3%) stddev-sans-first:470.96 12:53:45 INFO - PROCESS | 1724 | Values: 2600.1 2637.1 2658.0 2660.7 2669.6 4687.7 4707.4 4756.9 4791.3 4836.5 4744.5 4756.9 4770.4 4793.6 4847.3 4344.4 4394.5 4412.0 4432.4 4463.3 4351.9 4370.3 4383.6 4419.0 4459.4 4453.5 4467.1 4473.2 4481.9 4487.4 4290.7 4321.2 4331.7 4415.4 4483.2 4301.7 4316.6 4330.3 4359.8 4392.6 4728.8 4743.1 4759.1 4759.5 4789.9 5051.2 5085.6 5090.6 5091.2 5141.4 4972.4 5002.2 5061.0 5147.7 5152.1 4746.5 4782.4 4785.7 4785.7 4847.9 5266.3 5271.4 5275.6 5275.8 5278.9 5034.9 5043.1 5045.8 5047.1 5083.8 4939.4 4953.2 5002.3 5071.8 5098.6 5103.9 5115.2 5138.8 5155.0 5157.6 5084.8 5091.1 5092.6 5094.1 5141.1 4239.8 4250.3 4388.8 4396.8 4436.6 3752.4 3770.4 3771.8 3785.5 3834.8 4380.6 4388.5 4389.5 4389.7 4426.9 5132.7 5133.1 5134.7 5136.5 5189.2 4239.6 4261.0 4285.3 4300.3 4367.7 4559.0 4563.5 4592.9 4601.1 4620.2 4702.8 4704.6 4708.8 4715.4 4716.5 4962.9 5009.5 5015.1 5019.1 5052.9 4763.8 4782.4 4784.5 4813.3 4853.6 5065.5 5102.9 5103.7 5104.5 5163.6 4955.7 5156.7 5189.1 5199.3 5202.9 4870.1 4915.2 4947.6 4970.7 5000.4 4959.3 4966.7 4998.1 5003.6 5007.9 4891.3 4898.4 4900.5 4915.5 4945.1 4847.3 4933.0 4943.5 4951.7 4998.1 4825.2 4860.9 4871.4 4876.9 4884.7 12:53:45 INFO - PROCESS | 1724 | 12:53:45 INFO - PROCESS | 1724 | [#1] ext.html Cycles:180 Average:42644.37 Median:184048.92 stddev:74637.17 (40.6%) stddev-sans-first:74779.49 12:53:45 INFO - PROCESS | 1724 | Values: 504.9 513.1 524.1 527.2 530.2 27250.7 28039.2 37001.0 38082.0 38472.4 38561.0 38914.4 38986.8 39013.2 39040.8 7489.8 7662.7 7663.3 7666.0 7669.0 7146.8 7287.3 9474.9 9702.3 9719.5 9906.3 9965.0 9973.0 9974.8 9987.1 9851.0 9907.3 9915.1 9916.6 9930.6 9700.6 9730.8 9768.3 9771.5 9778.6 36058.8 36412.5 36427.5 36434.5 36452.0 3114.7 3128.8 3209.7 3313.7 3588.7 24545.8 24651.0 25123.2 25171.4 28665.9 3391.9 3443.8 3484.5 3508.1 3546.1 228544.0 228820.0 228863.0 228914.0 229904.9 50297.5 50530.2 50640.2 50655.0 50781.7 53277.5 53462.0 53500.2 53563.5 53582.2 13287.4 13475.8 13480.3 13483.8 13485.7 8549.0 8682.6 10527.7 10632.8 10653.1 13812.4 14552.9 15384.4 15457.0 16169.8 5793.4 5944.5 5964.2 6035.9 6100.5 770.6 871.1 890.1 956.0 1001.9 26274.2 27325.2 27468.8 27555.3 27848.3 887.4 897.5 901.5 905.7 911.6 14023.9 14525.9 14761.4 14946.9 14974.3 331322.0 333984.0 334022.0 334627.0 335118.0 47639.0 47801.3 47803.0 47821.8 47914.8 1030.3 1094.6 1123.7 1173.7 1184.5 26857.0 28035.3 28297.0 29034.4 29059.1 40612.8 41119.4 41275.0 41277.0 41315.0 266754.0 267878.0 267882.0 268132.0 326922.0 21306.7 21587.2 21737.0 21773.0 21806.8 33013.5 33200.7 33470.8 34261.8 34609.0 28828.7 29096.6 29437.7 29444.5 29947.3 28967.6 29679.3 29697.6 29944.9 30265.5 29069.9 29071.4 29149.4 29295.0 30417.5 24877.6 26193.0 29322.9 29333.4 29735.3 22601.4 22689.7 22897.8 23137.7 23310.9 12:53:45 INFO - PROCESS | 1724 | 12:53:45 INFO - PROCESS | 1724 | [#2] jquery.html Cycles:180 Average:21135.07 Median:41033.49 stddev:52315.32 (127.5%) stddev-sans-first:52438.78 12:53:45 INFO - PROCESS | 1724 | Values: 339.5 342.3 356.9 358.5 376.3 12331.3 15361.3 15374.7 15938.5 16842.4 16520.2 16614.3 16776.3 16925.1 17060.4 4863.0 4866.8 4979.4 5033.9 5090.5 3759.2 3957.7 4948.2 4953.1 4991.6 5583.7 5845.8 5858.6 5940.6 5944.9 5647.3 5715.7 5849.0 5940.6 5967.6 5095.4 5099.6 5120.6 5122.6 5124.1 18582.2 19260.2 19424.0 19461.4 19488.8 1936.9 1962.5 2112.6 2453.2 2505.4 12043.6 12522.6 12781.3 13066.2 13082.9 1690.3 1702.4 1723.7 1726.7 1801.5 58868.4 59828.0 60781.4 60981.0 62705.7 8565.4 8783.6 8941.7 9130.0 9230.2 12336.9 12349.8 12351.6 12368.1 12376.9 6576.2 6713.9 6882.2 6886.1 6905.5 6427.1 6439.4 6562.6 6571.9 6669.4 5733.4 5777.3 5791.0 5879.9 6009.7 1579.9 1643.4 1644.7 1660.5 1678.9 781.9 786.5 814.6 840.7 867.9 15705.1 16226.4 16679.2 16872.4 17115.0 831.8 836.5 836.9 881.1 897.9 9327.8 9490.5 9692.4 9888.9 9919.7 313784.0 317633.0 318340.5 319440.0 319643.0 61438.0 61616.4 61674.4 62500.7 63249.4 913.8 914.7 937.3 938.3 945.0 14614.9 14615.7 14914.3 14988.2 15518.0 31279.7 31622.4 32111.7 32889.8 32942.5 40744.4 40910.6 41156.4 41326.4 42835.6 4482.0 6785.7 7032.9 7408.0 7526.2 11236.4 11489.6 11554.9 11593.5 11795.0 9625.8 9704.3 10101.3 10244.9 10427.5 9849.6 10116.6 10152.7 10207.4 10361.3 10197.5 10382.3 10395.7 10432.2 10464.7 7201.8 7250.6 7381.4 7478.9 7639.1 10198.7 10439.7 10455.2 10522.5 10666.9 12:53:45 INFO - PROCESS | 1724 | 12:53:45 INFO - PROCESS | 1724 | [#3] mootools.html Cycles:180 Average:4673.36 Median:4848.71 stddev:2496.08 (51.5%) stddev-sans-first:2489.62 12:53:45 INFO - PROCESS | 1724 | Values: 1224.3 1319.4 1320.4 1386.5 1644.5 6106.4 6847.1 7133.4 7134.1 7278.3 7073.9 7142.4 7146.4 7163.0 7170.1 1812.1 1888.2 2071.6 2109.2 2109.4 2066.5 2136.3 2142.7 2152.9 2153.9 2085.7 2103.3 2113.9 2115.5 2127.7 2086.6 2104.8 2108.2 2118.2 2118.5 2028.0 2042.8 2062.6 2062.6 2066.5 7093.4 7221.2 7238.7 7241.5 7243.3 4227.2 4356.4 4356.6 4361.8 4374.7 2770.2 2941.5 2997.4 2999.9 3021.5 891.5 923.6 944.9 948.8 948.8 9134.7 9154.3 9180.3 9205.6 9209.3 3678.7 3860.1 3889.3 3891.9 4070.4 8131.6 8132.4 8141.5 8151.0 8158.0 4436.9 4486.6 4487.6 4511.8 4514.5 3529.8 3623.0 4075.1 4089.6 4096.1 3306.9 3348.2 3460.6 3465.8 3493.8 1125.2 1126.4 1156.4 1158.8 1175.7 792.6 793.5 805.6 822.4 826.5 4837.1 4860.4 4917.6 5003.6 5118.1 398.6 412.6 415.4 416.8 420.6 3380.5 3450.5 3472.7 3481.7 3597.8 8089.3 8302.3 8398.3 8468.2 8475.7 8334.7 8335.1 8342.1 8346.7 8360.3 6373.9 6467.2 6552.0 6552.3 6614.7 4614.9 4639.2 4696.2 4698.8 4708.5 7535.4 7538.7 7658.7 7717.2 7751.1 7730.8 7821.5 7825.7 7837.5 7840.8 5614.8 5795.4 6030.7 6111.3 6121.7 6576.7 6745.7 6769.5 6893.5 6899.9 6122.5 6248.7 6267.6 6388.8 6393.2 6093.4 6120.5 6128.4 6132.0 6137.9 5806.7 5913.2 5916.1 5916.8 5917.6 4432.9 4520.8 4541.1 4621.7 4627.7 4276.9 4302.4 4334.7 4393.4 4399.7 12:53:45 INFO - PROCESS | 1724 | 12:53:45 INFO - PROCESS | 1724 | [#4] prototype.html Cycles:180 Average:4083.97 Median:4679.35 stddev:1211.59 (25.9%) stddev-sans-first:1181.40 12:53:45 INFO - PROCESS | 1724 | Values: 309.3 318.8 321.9 333.9 334.3 4759.6 4825.0 4831.8 4845.4 4873.0 4779.8 4787.7 4793.8 4797.9 4801.2 3556.9 3628.4 3643.7 3662.9 3693.4 3688.2 3710.2 3736.0 3743.3 3780.8 3713.0 3715.6 3759.9 3760.8 3767.4 3446.6 3725.1 3725.6 3734.1 3735.4 3115.2 3118.3 3123.8 3128.8 3130.7 4576.3 4603.5 4619.9 4629.6 4634.7 4116.8 4123.9 4124.5 4124.8 4128.5 4766.9 4935.3 4967.6 4996.7 5007.3 3402.3 3405.1 3410.5 3416.8 3420.1 5184.8 5199.9 5208.7 5243.2 5256.4 3372.2 3468.6 3468.9 3469.9 3473.5 3507.0 3511.9 3516.3 3523.8 3531.8 4047.8 4054.3 4076.7 4095.5 4095.6 4941.7 4945.9 4958.0 4962.6 4971.8 1146.5 1170.2 1174.2 1185.6 1187.2 772.2 781.9 788.5 790.3 792.5 4248.4 4282.3 4301.8 4355.3 4472.5 5148.7 5178.8 5195.6 5207.9 5214.6 4485.3 4494.3 4502.6 4509.6 4511.4 2607.2 2697.4 2698.8 2699.9 2717.4 4689.5 4727.8 4728.5 4730.7 4759.7 5162.0 5171.8 5177.8 5179.8 5188.5 4545.4 4653.3 4669.2 4704.9 4752.8 4999.8 5038.6 5103.5 5105.2 5105.5 4972.8 4977.9 4989.9 5002.9 5032.5 4461.6 4707.7 4708.4 4741.9 4745.9 3364.8 3405.9 3429.6 3430.1 3436.2 5121.6 5126.3 5127.4 5127.8 5134.8 4629.3 4894.9 4896.5 4904.4 4961.5 4904.6 4907.7 4913.2 4916.2 4923.8 4846.8 4854.6 4857.2 4859.3 4864.3 4656.8 4921.6 4928.6 4965.0 4977.7 4831.7 4831.7 4845.7 4850.5 4856.0 12:53:45 INFO - PROCESS | 1724 | 12:53:45 INFO - PROCESS | 1724 | [#5] yui.html Cycles:180 Average:14901.94 Median:23148.77 stddev:18303.10 (79.1%) stddev-sans-first:18323.08 12:53:45 INFO - PROCESS | 1724 | Values: 634.3 639.0 660.5 677.7 715.8 14173.7 14719.4 14756.4 14779.0 14784.0 14110.4 14759.8 14828.6 14894.7 14901.9 619.7 638.5 761.4 776.0 804.2 774.6 792.4 793.0 793.2 793.3 793.1 793.3 794.0 794.0 797.9 646.8 664.8 788.1 792.4 797.1 602.9 603.1 603.5 603.7 604.6 13061.4 13100.8 13108.5 13111.9 13123.7 12618.2 12647.7 12651.2 12911.5 12952.3 11560.9 11584.2 11698.2 11817.5 12058.5 3130.6 3196.2 3237.3 3317.8 3347.0 45833.0 59089.7 63113.4 63661.4 65320.3 9425.3 10025.3 10155.5 10224.6 10410.7 18228.6 18399.4 18491.9 18615.7 18677.9 6393.6 6435.4 6546.3 6562.6 6688.2 3384.5 3471.2 3478.8 3485.0 3506.1 2816.0 2888.3 2907.4 2908.6 2914.6 464.5 464.8 472.1 477.0 480.3 557.8 593.5 613.1 615.6 622.0 7752.7 7851.7 7925.2 8415.2 8454.7 480.7 518.6 548.4 552.0 572.1 3900.5 4083.7 4309.0 4403.9 4439.7 63371.0 63683.7 64131.8 64242.4 64970.7 57070.7 58169.0 58567.4 59588.0 60394.0 50209.5 51861.5 52990.5 53494.7 53866.7 8177.4 8516.0 8546.6 8571.8 8644.9 35341.8 35345.6 35455.0 35986.0 37219.0 44680.0 45505.3 49096.0 49278.0 51466.7 11007.2 11036.6 11062.8 11209.3 11562.7 12539.4 12553.9 12699.5 12805.7 13001.5 11994.5 12182.5 12221.6 12309.7 12942.2 11601.0 11734.5 12075.3 12083.7 12212.5 11888.0 11979.8 12090.2 12477.4 12661.9 8829.7 9234.7 9530.1 9671.8 10261.8 8654.7 9619.8 10006.1 10012.1 10028.3 12:53:45 INFO - PROCESS | 1724 | -------- Summary: end -------- 12:53:45 INFO - PROCESS | 1724 | 12:53:46 INFO - TEST-INFO | 1724: exit 0 12:53:46 INFO - TEST-OK | dromaeo_css | took 1121483ms 12:53:46 INFO - TEST-START | kraken 12:53:46 INFO - operating with platform_type : linux_ 12:53:46 INFO - Initialising browser for kraken test... 12:53:46 INFO - TEST-INFO | started process 2021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3jQjki/profile http://localhost:39065/getInfo.html) 12:53:50 INFO - PROCESS | 2021 | __metrics Screen width/height:1600/1200 12:53:50 INFO - PROCESS | 2021 | colorDepth:24 12:53:50 INFO - PROCESS | 2021 | Browser inner width/height: 1024/697 12:53:50 INFO - PROCESS | 2021 | __metrics 12:53:50 INFO - PROCESS | 2021 | 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" 12:53:50 INFO - PROCESS | 2021 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:53:51 INFO - PROCESS | 2021 | console.error: PushService: 12:53:51 INFO - PROCESS | 2021 | stateChangeProcessEnqueue: Error transitioning state 12:53:51 INFO - PROCESS | 2021 | UnknownError 12:53:52 INFO - TEST-INFO | 2021: exit 0 12:53:52 INFO - Browser initialized. 12:53:52 INFO - Running cycle 1/1 for kraken test... 12:53:52 INFO - TEST-INFO | started process 2104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3jQjki/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:04 INFO - PROCESS | 2104 | RSS: Main: 154210304 12:54:04 INFO - PROCESS | 2104 | 12:54:06 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39065/tests/kraken/driver.html?testName=audio-beat-detection) 12:54:07 INFO - PROCESS | 2104 | RSS: Main: 206417920 12:54:07 INFO - PROCESS | 2104 | 12:54:10 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39065/tests/kraken/driver.html?testName=audio-dft) 12:54:11 INFO - PROCESS | 2104 | RSS: Main: 186290176 12:54:11 INFO - PROCESS | 2104 | 12:54:14 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39065/tests/kraken/driver.html?testName=audio-fft) 12:54:14 INFO - PROCESS | 2104 | RSS: Main: 268181504 12:54:14 INFO - PROCESS | 2104 | 12:54:17 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39065/tests/kraken/driver.html?testName=audio-oscillator) 12:54:17 INFO - PROCESS | 2104 | RSS: Main: 179699712 12:54:17 INFO - PROCESS | 2104 | 12:54:19 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:54:20 INFO - PROCESS | 2104 | RSS: Main: 183197696 12:54:20 INFO - PROCESS | 2104 | 12:54:23 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39065/tests/kraken/driver.html?testName=imaging-darkroom) 12:54:24 INFO - PROCESS | 2104 | RSS: Main: 223002624 12:54:24 INFO - PROCESS | 2104 | 12:54:28 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39065/tests/kraken/driver.html?testName=imaging-desaturate) 12:54:28 INFO - PROCESS | 2104 | RSS: Main: 216281088 12:54:28 INFO - PROCESS | 2104 | 12:54:31 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39065/tests/kraken/driver.html?testName=json-parse-financial) 12:54:32 INFO - PROCESS | 2104 | RSS: Main: 218439680 12:54:32 INFO - PROCESS | 2104 | 12:54:33 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:54:34 INFO - PROCESS | 2104 | RSS: Main: 181772288 12:54:34 INFO - PROCESS | 2104 | 12:54:36 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:54:37 INFO - PROCESS | 2104 | RSS: Main: 189120512 12:54:37 INFO - PROCESS | 2104 | 12:54:39 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:54:39 INFO - PROCESS | 2104 | RSS: Main: 197885952 12:54:39 INFO - PROCESS | 2104 | 12:54:42 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:54:43 INFO - PROCESS | 2104 | RSS: Main: 207364096 12:54:43 INFO - PROCESS | 2104 | 12:54:46 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:54:47 INFO - PROCESS | 2104 | RSS: Main: 203399168 12:54:47 INFO - PROCESS | 2104 | 12:54:48 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:39065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39065/tests/kraken/driver.html?testName=ai-astar) 12:54:49 INFO - PROCESS | 2104 | RSS: Main: 254566400 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | __start_tp_report 12:54:49 INFO - PROCESS | 2104 | _x_x_mozilla_page_load 12:54:49 INFO - PROCESS | 2104 | _x_x_mozilla_page_load_details 12:54:49 INFO - PROCESS | 2104 | |i|pagename|runs| 12:54:49 INFO - PROCESS | 2104 | |0;ai-astar;109;116;115;118;117;115;115;117;116;116 12:54:49 INFO - PROCESS | 2104 | |1;audio-beat-detection;152;125;126;165;128;128;123;124;151;131 12:54:49 INFO - PROCESS | 2104 | |2;audio-dft;161;162;162;162;163;162;162;163;162;163 12:54:49 INFO - PROCESS | 2104 | |3;audio-fft;75;76;76;102;77;76;76;76;92;76 12:54:49 INFO - PROCESS | 2104 | |4;audio-oscillator;85;85;127;84;85;87;105;86;85;110 12:54:49 INFO - PROCESS | 2104 | |5;imaging-gaussian-blur;127;127;127;127;127;127;127;127;127;126 12:54:49 INFO - PROCESS | 2104 | |6;imaging-darkroom;147;147;147;148;147;148;146;146;146;148 12:54:49 INFO - PROCESS | 2104 | |7;imaging-desaturate;95;95;95;95;96;95;96;96;96;95 12:54:49 INFO - PROCESS | 2104 | |8;json-parse-financial;67;65;65;66;66;67;65;67;65;67 12:54:49 INFO - PROCESS | 2104 | |9;json-stringify-tinderbox;66;67;66;66;67;65;68;65;67;67 12:54:49 INFO - PROCESS | 2104 | |10;stanford-crypto-aes;84;84;84;84;86;84;84;85;83;84 12:54:49 INFO - PROCESS | 2104 | |11;stanford-crypto-ccm;153;136;167;140;133;133;134;142;180;153 12:54:49 INFO - PROCESS | 2104 | |12;stanford-crypto-pbkdf2;187;182;178;184;179;183;177;180;178;183 12:54:49 INFO - PROCESS | 2104 | |13;stanford-crypto-sha256-iterative;69;69;68;68;69;69;69;69;67;71 12:54:49 INFO - PROCESS | 2104 | __end_tp_report 12:54:49 INFO - PROCESS | 2104 | __start_cc_report 12:54:49 INFO - PROCESS | 2104 | _x_x_mozilla_cycle_collect,1972 12:54:49 INFO - PROCESS | 2104 | __end_cc_report 12:54:49 INFO - PROCESS | 2104 | __startTimestamp1482267289101__endTimestamp 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | ------- Summary: start ------- 12:54:49 INFO - PROCESS | 2104 | Number of tests: 14 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:2.46 (2.1%) stddev-sans-first:1.05 12:54:49 INFO - PROCESS | 2104 | Values: 109.0 116.0 115.0 118.0 117.0 115.0 115.0 117.0 116.0 116.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:129.50 stddev:14.92 (11.5%) stddev-sans-first:14.55 12:54:49 INFO - PROCESS | 2104 | Values: 152.0 125.0 126.0 165.0 128.0 128.0 123.0 124.0 151.0 131.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 12:54:49 INFO - PROCESS | 2104 | Values: 161.0 162.0 162.0 162.0 163.0 162.0 162.0 163.0 162.0 163.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.00 stddev:9.17 (12.1%) stddev-sans-first:9.54 12:54:49 INFO - PROCESS | 2104 | Values: 75.0 76.0 76.0 102.0 77.0 76.0 76.0 76.0 92.0 76.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:85.00 stddev:14.92 (17.6%) stddev-sans-first:15.47 12:54:49 INFO - PROCESS | 2104 | Values: 85.0 85.0 127.0 84.0 85.0 87.0 105.0 86.0 85.0 110.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#5] imaging-gaussian-blur Cycles:10 Average:126.90 Median:127.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 12:54:49 INFO - PROCESS | 2104 | Values: 127.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 126.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 12:54:49 INFO - PROCESS | 2104 | Values: 147.0 147.0 147.0 148.0 147.0 148.0 146.0 146.0 146.0 148.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:54:49 INFO - PROCESS | 2104 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.50 stddev:0.94 (1.4%) stddev-sans-first:0.93 12:54:49 INFO - PROCESS | 2104 | Values: 67.0 65.0 65.0 66.0 66.0 67.0 65.0 67.0 65.0 67.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 12:54:49 INFO - PROCESS | 2104 | Values: 66.0 67.0 66.0 66.0 67.0 65.0 68.0 65.0 67.0 67.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:0.79 (0.9%) stddev-sans-first:0.83 12:54:49 INFO - PROCESS | 2104 | Values: 84.0 84.0 84.0 84.0 86.0 84.0 84.0 85.0 83.0 84.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:147.50 stddev:16.04 (10.9%) stddev-sans-first:16.88 12:54:49 INFO - PROCESS | 2104 | Values: 153.0 136.0 167.0 140.0 133.0 133.0 134.0 142.0 180.0 153.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:182.50 stddev:3.21 (1.8%) stddev-sans-first:2.60 12:54:49 INFO - PROCESS | 2104 | Values: 187.0 182.0 178.0 184.0 179.0 183.0 177.0 180.0 178.0 183.0 12:54:49 INFO - PROCESS | 2104 | 12:54:49 INFO - PROCESS | 2104 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 12:54:49 INFO - PROCESS | 2104 | Values: 69.0 69.0 68.0 68.0 69.0 69.0 69.0 69.0 67.0 71.0 12:54:49 INFO - PROCESS | 2104 | -------- Summary: end -------- 12:54:49 INFO - PROCESS | 2104 | 12:54:50 INFO - TEST-INFO | 2104: exit 0 12:54:50 INFO - TEST-OK | kraken | took 63730ms 12:54:50 INFO - SUITE-END | took 1185s 12:54:50 INFO - Completed test suite (00:19:45) 12:54:50 INFO - javascript benchmark 12:54:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.1289567994722, 2637.1429285482222, 2658.029819116023, 2660.747229013243, 2669.5728683410657, 4687.671862969585, 4707.435107787066, 4756.90486190276, 4791.305260737191, 4836.540528649777, 4744.501827308135, 4756.9286460703115, 4770.379850619414, 4793.5925446337105, 4847.321375007502, 4344.435223420966, 4394.494633117192, 4412.029353542232, 4432.401625780527, 4463.263561512346, 4351.912961740763, 4370.344448332744, 4383.561643835623, 4418.955810441903, 4459.37568740375, 4453.465584129909, 4467.084247729208, 4473.1501014807245, 4481.887952801189, 4487.39420178275, 4290.721103128287, 4321.24378233811, 4331.740095594275, 4415.381846541487, 4483.193025255453, 4301.677374196916, 4316.611504964537, 4330.307150855848, 4359.782010899442, 4392.648588112943, 4728.787204575802, 4743.0988112258565, 4759.095771803346, 4759.524047595248, 4789.87437952081, 5051.242313652945, 5085.644004919657, 5090.592752579785, 5091.23631455281, 5141.383034035902, 4972.353594032753, 5002.24966255061, 5060.974695126501, 5147.691138531663, 5152.098382782998, 4746.5253474652945, 4782.378290822206, 4785.712857228507, 4785.736784476818, 4847.854564363075, 5266.2890509781455, 5271.42014378418, 5275.60432967529, 5275.762590683352, 5278.9208161877605, 5034.874128146826, 5043.0922433961505, 5045.84862454127, 5047.116754567936, 5083.796648134034, 4939.382577177853, 4953.23224900141, 5002.274670172805, 5071.7971281149075, 5098.566621837112, 5103.923441148386, 5115.18157094863, 5138.820141295037, 5155.0, 5157.58739300855, 5084.7966081356335, 5091.0836049511445, 5092.592592592584, 5094.133997220481, 5141.074606570854, 4239.766812825324, 4250.277452833026, 4388.780560971939, 4396.846110386121, 4436.578525040116, 3752.3620984432714, 3770.3967365221984, 3771.849126034928, 3785.488958990556, 3834.827432765532, 4380.62764665007, 4388.451443569554, 4389.473263208435, 4389.6927215095275, 4426.933595996063, 5132.692038477629, 5133.076046311625, 5134.743262836843, 5136.4606716295, 5189.169732842803, 4239.554846741109, 4261.019965407973, 4285.271503844354, 4300.333448315516, 4367.694261401735, 4559.042601053816, 4563.452385713736, 4592.885177870513, 4601.148787474328, 4620.214563524209, 4702.811887524529, 4704.6236301096515, 4708.788104535236, 4715.3869996900185, 4716.504766999416, 4962.900741985068, 5009.524095210949, 5015.147424937696, 5019.121653710659, 5052.9494705052475, 4763.7618119094595, 4782.402199725035, 4784.473707892199, 4813.278008298783, 4853.563179313879, 5065.518775716301, 5102.948970510396, 5103.744812759422, 5104.489551044866, 5163.612729045261, 4955.677880937727, 5156.7421628917655, 5189.091908915849, 5199.324087868553, 5202.895942081062, 4870.0746858096845, 4915.21356582945, 4947.554720075211, 4970.726610036482, 5000.399952005782, 4959.305697202467, 4966.652334336562, 4998.050370429607, 5003.624728145331, 5007.899842003212, 4891.315215869852, 4898.363212782316, 4900.460949295646, 4915.483874193301, 4945.1346014448045, 4847.2729090636685, 4933.038057578881, 4943.480934501826, 4951.653384263067, 4998.125328067501, 4825.155597770447, 4860.902781944271, 4871.439784424837, 4876.853694389174, 4884.706917584814], "value": 4676.908101549121, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.8586395809174, 513.1276829390035, 524.0828550037436, 527.1907621800536, 530.1596968804445, 27250.727492725066, 28039.158825235223, 37001.0, 38082.0, 38472.422913656315, 38561.0, 38914.41628375577, 38986.8050659747, 39013.21973560527, 39040.80479597605, 7489.812754681149, 7662.731804386847, 7663.348615367672, 7665.961670191641, 7669.0, 7146.785596432115, 7287.344139027487, 9474.905250947471, 9702.272329575275, 9719.514024298793, 9906.257030722689, 9965.0, 9973.0, 9974.750631234205, 9987.051230133126, 9850.950745246264, 9907.306488545804, 9915.107640312406, 9916.553755081039, 9930.602775888956, 9700.563474643657, 9730.810567622299, 9768.316217864753, 9771.462569558671, 9778.55996480153, 36058.819705901566, 36412.45381319282, 36427.45358819593, 36434.45348319777, 36452.0, 3114.7352475039647, 3128.8279144647036, 3209.6950789674943, 3313.701766840996, 3588.7129029677562, 24545.754542454524, 24651.0, 25123.24630261095, 25171.37071573207, 28665.856670716723, 3391.86432542698, 3443.793372397639, 3484.4773284007347, 3508.0528257370365, 3546.131197856516, 228544.0, 228820.0, 228863.0, 228914.0, 229904.85047574822, 50297.49702502928, 50530.242046369334, 50640.214788187004, 50655.0, 50781.74609127005, 53277.54114423984, 53462.0, 53500.197497037574, 53563.464365355845, 53582.196267056024, 13287.402066907012, 13475.797863032063, 13480.258585777876, 13483.797743033861, 13485.730285394236, 8548.957255213683, 8682.565871706516, 10527.684169474927, 10632.840507392395, 10653.094486968539, 13812.447502100005, 14552.85447145515, 15384.384624615113, 15457.0, 16169.838301617068, 5793.420657934257, 5944.524438044946, 5964.224650795456, 6035.909461358083, 6100.511959043266, 770.6378002338892, 871.13322244366, 890.0565400675305, 955.9904400956041, 1001.8547310639916, 26274.21177364682, 27325.180244592695, 27468.808103163738, 27555.31111722183, 27848.303792404946, 887.40100432208, 897.4929165021741, 901.4906577783531, 905.7101727447154, 911.6490151291667, 14023.941617450946, 14525.854741452451, 14761.40954361835, 14946.925265373604, 14974.326155323037, 331322.0, 333984.0, 334022.0, 334627.0, 335118.0, 47639.0, 47801.28298075531, 47803.043939121715, 47821.76089119532, 47914.760426197645, 1030.3199888073834, 1094.6168840905618, 1123.662901129658, 1173.6713720158368, 1184.5084290019718, 26857.0, 28035.299117522227, 28297.0, 29034.41931161407, 29059.12822615325, 40612.79693601513, 41119.38320925129, 41275.0, 41277.0, 41315.0, 266754.0, 267878.0, 267882.0, 268132.0, 326922.0, 21306.680399793706, 21587.2444464443, 21737.0, 21773.0, 21806.781932180475, 33013.50479742758, 33200.66799331976, 33470.832645836614, 34261.82869085639, 34609.0, 28828.711712882603, 29096.596796046593, 29437.705622943497, 29444.51342156819, 29947.251318717208, 28967.5654865173, 29679.25801854971, 29697.554536681535, 29944.850275748482, 30265.546016809327, 29069.85465072661, 29071.418571628026, 29149.417011659225, 29295.0, 30417.543736843523, 24877.626835597843, 26193.0, 29322.853385732935, 29333.41333173367, 29735.25661858471, 22601.434964126027, 22689.659655105515, 22897.771022289562, 23137.652935206323, 23310.88344558266], "value": 16556.594076047924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.5247648965248, 342.32732680283254, 356.87866125517326, 358.5303252738912, 376.28130271182033, 12331.260124392531, 15361.30874110665, 15374.692506149884, 15938.52184434466, 16842.410515631957, 16520.173991300417, 16614.335426582922, 16776.328946842143, 16925.06912119833, 17060.402885898995, 4862.97568512157, 4866.805327786893, 4979.427365852937, 5033.949660503385, 5090.490950904898, 3759.248150369923, 3957.663598594123, 4948.233023881304, 4953.1332016896895, 4991.575716064139, 5583.664980101186, 5845.7953971611005, 5858.589898707092, 5940.6435613863305, 5944.851378715523, 5647.322321321468, 5715.685637289947, 5849.03490923997, 5940.584159108864, 5967.552433567478, 5095.414027386861, 5099.59203263738, 5120.590352771769, 5122.564582010534, 5124.128898087334, 18582.163802628915, 19260.22959081635, 19424.028798560015, 19461.416157515156, 19488.80511194884, 1936.8741031832885, 1962.4856829777548, 2112.5774845031056, 2453.178185307924, 2505.3736565858535, 12043.578474753342, 12522.624321270285, 12781.338426004653, 13066.150700204456, 13082.86917130826, 1690.2647348403484, 1702.3871406293724, 1723.7414387841798, 1726.7496213049037, 1801.5135913303334, 58868.41131588715, 59828.0, 60781.39218607802, 60981.0, 62705.68647156735, 8565.400421970402, 8783.604737786687, 8941.736266262767, 9129.954350228207, 9230.215431688248, 12336.938315308365, 12349.814752778715, 12351.567695130627, 12368.134230603951, 12376.88608025282, 6576.243731970884, 6713.932860671429, 6882.174139103339, 6886.10480637514, 6905.516613837083, 6427.100205971168, 6439.361760605243, 6562.573432726857, 6571.868562628721, 6669.399754022064, 5733.397993210736, 5777.277840269966, 5791.0, 5879.941200588025, 6009.729562169713, 1579.9447019354268, 1643.3755173034172, 1644.7203975324223, 1660.4603503861294, 1678.9296325098135, 781.9491733037335, 786.4691333349966, 814.6171299489231, 840.7388916625063, 867.9088695686988, 15705.136217508147, 16226.350945962029, 16679.249433775265, 16872.409465668887, 17115.0, 831.7629475599425, 836.5399030533182, 836.8870202522703, 881.1496905486237, 897.8877640294963, 9327.766805829773, 9490.478023708762, 9692.369995950241, 9888.851667224853, 9919.738406658767, 313784.0, 317633.0, 318340.47382182145, 319440.0, 319643.0, 61438.0, 61616.38383616106, 61674.38325616776, 62500.68749656223, 63249.36750632435, 913.7624217703445, 914.6570036236411, 937.3391758810022, 938.2822141062093, 944.960543402252, 14614.853851461774, 14615.707685846011, 14914.328855201325, 14988.1756503389, 15518.0, 31279.68720312859, 31622.367552648357, 32111.67888321087, 32889.83555082305, 32942.50586241256, 40744.3888341681, 40910.59089409068, 41156.38265426081, 41326.38010429786, 42835.571644284406, 4481.955180448153, 6785.660716964033, 7032.859342813217, 7408.0, 7526.209747976383, 11236.381998990135, 11489.597864074718, 11554.884451155382, 11593.536258549564, 11795.0, 9625.759356016155, 9704.320697551104, 10101.343412678152, 10244.897551024394, 10427.530761115617, 9849.556769945513, 10116.645917392856, 10152.746181345525, 10207.438590877573, 10361.274710770174, 10197.490125493843, 10382.273240873066, 10395.688129356131, 10432.165426765689, 10464.686059418229, 7201.783946481614, 7250.564966102051, 7381.409487241115, 7478.850422991401, 7639.083310002835, 10198.745031374276, 10439.686809395731, 10455.215858810467, 10522.473876306001, 10666.946665266623], "value": 7931.81561589448, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.3021477757682, 1319.4458327502448, 1320.4124164746688, 1386.4869998100698, 1644.5395289318994, 6106.358832322609, 6847.075644787952, 7133.393661538776, 7134.072570565819, 7278.344948954593, 7073.858522829541, 7142.392896603782, 7146.428285737142, 7162.964185179067, 7170.06789117414, 1812.1482903035553, 1888.1975160556776, 2071.5960387724363, 2109.166879082761, 2109.3882773995524, 2066.5350296183387, 2136.2629892687078, 2142.657174852024, 2152.924647637333, 2153.881536515491, 2085.7184280122215, 2103.3059090500096, 2113.9048742806613, 2115.481706981784, 2127.680847872816, 2086.6139764143604, 2104.8000439958178, 2108.1988844239245, 2118.248021952208, 2118.5127420693175, 2027.979720202794, 2042.816146546818, 2062.5565503416688, 2062.6287268291703, 2066.4523901166203, 7093.3970612498, 7221.24176961422, 7238.71045158193, 7241.493095483265, 7243.348098671092, 4227.154569086164, 4356.390105385249, 4356.586124318184, 4361.847335343247, 4374.6500279977845, 2770.2381844992788, 2941.5440606705993, 2997.4155039767256, 2999.895003674861, 3021.5165573508134, 891.5185799668171, 923.630547780893, 944.9055094490565, 948.8054948735493, 948.8292107420662, 9134.680286189952, 9154.267658587298, 9180.265578753684, 9205.585748641328, 9209.263258939269, 3678.6873115785456, 3860.092878173627, 3889.2999260132883, 3891.8832435026993, 4070.4097905804083, 8131.634076466573, 8132.390070744717, 8141.470804397695, 8150.959245203855, 8158.021037475541, 4436.866893993185, 4486.64106871456, 4487.6185524230805, 4511.774411279423, 4514.503404625489, 3529.8411571479346, 3623.0, 4075.144219713893, 4089.6114869087387, 4096.119334343071, 3306.8842590509216, 3348.2131699050706, 3460.636633153533, 3465.7747246428903, 3493.7729047612333, 1125.1842414249604, 1126.442411006557, 1156.4275683536534, 1158.8319693644544, 1175.6884425627215, 792.5918152151646, 793.4763056382875, 805.6414895371504, 822.3585603229491, 826.4669288309127, 4837.05677392905, 4860.36815214027, 4917.582005529499, 5003.649744517848, 5118.078745825787, 398.63126607887585, 412.6039002557578, 415.43085972218256, 416.7707760731646, 420.6340483779132, 3380.4591265397416, 3450.46517789743, 3472.6700963408434, 3481.721462283011, 3597.784132952031, 8089.31240844523, 8302.335813135056, 8398.328133749286, 8468.153184681483, 8475.660973560989, 8334.6666133354, 8335.124811894784, 8342.082370939192, 8346.666133354598, 8360.331173506105, 6373.872522549523, 6467.223933128054, 6551.967240163864, 6552.312007239267, 6614.735410583523, 4614.861554153381, 4639.234526303258, 4696.178168820375, 4698.801805539566, 4708.458527269408, 7535.434842386952, 7538.660760265691, 7658.73194438192, 7717.151113377412, 7751.108622508484, 7730.845383092419, 7821.530708157528, 7825.686972521035, 7837.451378403457, 7840.764777056697, 5614.803481878278, 5795.449432303924, 6030.668313242638, 6111.266648002091, 6121.693915304128, 6576.736930522917, 6745.696443660146, 6769.492288078315, 6893.482988775761, 6899.931000689929, 6122.510199183966, 6248.656323902229, 6267.62394256346, 6388.840278993062, 6393.1688880445245, 6093.390660933871, 6120.540959427972, 6128.417800308964, 6132.018876979841, 6137.938620613737, 5806.68063256525, 5913.231279933581, 5916.083007133901, 5916.763329466773, 5917.615355001911, 4432.911341773211, 4520.841770538015, 4541.069080838486, 4621.69958952667, 4627.67606267558, 4276.87169384919, 4302.376155457504, 4334.696571239983, 4393.406890069799, 4399.670024748093], "value": 3775.0618186497686, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.31178128663726, 318.82145998240986, 321.88894831283216, 333.89983005098463, 334.29463831315906, 4759.595434388077, 4824.997625985221, 4831.830885918994, 4845.4427740809815, 4872.951270487294, 4779.784909679064, 4787.688800227983, 4793.832215872445, 4797.856064318076, 4801.247544646197, 3556.8932932012017, 3628.4375921732044, 3643.6902863256655, 3662.8717994870185, 3693.3536631089587, 3688.17016171362, 3710.202306504101, 3736.009957361288, 3743.3262012837677, 3780.7731536107785, 3712.981435092821, 3715.5541335039834, 3759.9436008459893, 3760.7743535387963, 3767.3595488766973, 3446.6041253292456, 3725.1245957200035, 3725.640141348388, 3734.1411475360683, 3735.4210097434943, 3115.2367669921014, 3118.3451475190236, 3123.8281894495794, 3128.7966282191815, 3130.685112252859, 4576.313552967048, 4603.49361570227, 4619.884502887421, 4629.583337499607, 4634.675572709912, 4116.835326586933, 4123.8969025774295, 4124.52567954686, 4124.752514849089, 4128.545859955402, 4766.903612169221, 4935.333729946447, 4967.627427942919, 4996.650234483587, 5007.32401125847, 3402.2515046689687, 3405.1316914186973, 3410.4884267360094, 3416.79499230047, 3420.110771199506, 5184.792608295664, 5199.948000519984, 5208.66143700662, 5243.161094224905, 5256.395514515803, 3372.173817414749, 3468.5837699476224, 3468.930621387558, 3469.8785542505893, 3473.4963430302464, 3506.982465087658, 3511.894643160709, 3516.261585067113, 3523.823808809549, 3531.805750683686, 4047.797610119482, 4054.270231358325, 4076.6534844537955, 4095.4675892133832, 4095.5904409558807, 4941.678790878654, 4945.887175385509, 4957.975210123926, 4962.5533701967, 4971.825986090469, 1146.507001989136, 1170.2042611024415, 1174.1956759619688, 1185.5554167187304, 1187.1689817127872, 772.2432016623741, 781.9061712594525, 788.5465857132172, 790.3005839831791, 792.5126047480758, 4248.383984322256, 4282.336237883133, 4301.763403012865, 4355.324924636687, 4472.463304403493, 5148.6910785353, 5178.844634660966, 5195.558377537876, 5207.895842083137, 5214.558391461617, 4485.25993211123, 4494.258447356215, 4502.5591810620945, 4509.571590698878, 4511.390962220124, 2607.2178346495975, 2697.352635367537, 2698.7840972722133, 2699.9460010799676, 2717.4293398386167, 4689.50760170184, 4727.810887564528, 4728.503507131771, 4730.739809310521, 4759.714417134983, 5161.993411284839, 5171.793128274902, 5177.767000484987, 5179.8446046618665, 5188.455212202664, 4545.431821022372, 4653.325267836145, 4669.182892993645, 4704.858854234379, 4752.7623618818925, 4999.77501012448, 5038.622103342191, 5103.489651034867, 5105.157648987875, 5105.5193993741395, 4972.825951091694, 4977.900441991067, 4989.900201995867, 5002.874928126826, 5032.547070763502, 4461.643068554573, 4707.7175369477945, 4708.364370809897, 4741.928871067006, 4745.881352966204, 3364.8149351785887, 3405.863765449354, 3429.622741498383, 3430.125318043883, 3436.2096717754557, 5121.590272778094, 5126.333576635014, 5127.359080114986, 5127.79488820443, 5134.820281290137, 4629.259318509023, 4894.902101958012, 4896.48209055194, 4904.435989861069, 4961.5286547777905, 4904.607631389552, 4907.730074845775, 4913.238448040559, 4916.237983112624, 4923.827666031815, 4846.781894814671, 4854.56790246871, 4857.222844344888, 4859.31969524274, 4864.343313652753, 4656.790444429941, 4921.557059864486, 4928.619986403813, 4964.975175124246, 4977.651564390458, 4831.73425461603, 4831.73425461603, 4845.709257444564, 4850.490698476609, 4855.95144048555], "value": 3702.0285751746715, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.3434545245672, 638.961662300262, 660.4782222044585, 677.7018112030703, 715.7566427414678, 14173.716525669493, 14719.411223551046, 14756.409743610242, 14779.0, 14784.0, 14110.365033573487, 14759.77860332096, 14828.6292842679, 14894.702105957875, 14901.850981490183, 619.7118339971912, 638.5179189711761, 761.4479502360799, 775.9573223472706, 804.2078552625688, 774.6165648004246, 792.4056957282038, 792.9722459713911, 793.1830214878655, 793.2860425616933, 793.1196372027046, 793.3018943329862, 793.9563324017176, 793.9801504962393, 797.872340425532, 646.8350570604466, 664.7640087768821, 788.1055002572065, 792.3661071143063, 797.1430711984582, 602.8794241151787, 603.065248864263, 603.5171862509975, 603.704184949376, 604.5737754882797, 13061.412236449383, 13100.803487947689, 13108.541201058013, 13111.86888131116, 13123.737525249442, 12618.242905425612, 12647.747045059139, 12651.177673451288, 12911.548095816695, 12952.287624180666, 11560.884391156065, 11584.247023943417, 11698.181127321091, 11817.527298908033, 12058.457369418396, 3130.5773720547663, 3196.2329041030216, 3237.2554312508255, 3317.7511686623598, 3346.9959012296213, 45833.0, 59089.70455147697, 63113.36886631121, 63661.36338636647, 65320.3467965319, 9425.340226184102, 10025.298229123891, 10155.543000564992, 10224.6421375253, 10410.739731506774, 18228.635427291647, 18399.356022539414, 18491.907540462213, 18615.720764188547, 18677.906610467133, 6393.584417012879, 6435.388638079375, 6546.312637173123, 6562.639054852029, 6688.197416309977, 3384.526166336715, 3471.1842716961496, 3478.756487045933, 3485.041613556242, 3506.0708912138302, 2815.9859200703863, 2888.2634928093203, 2907.433050555164, 2908.578256152846, 2914.621099257083, 464.5447461487693, 464.8256903661127, 472.06295503425673, 477.01020382706025, 480.3011618095662, 557.8438037349549, 593.4925638578953, 613.1109890658563, 615.6367743031633, 622.0343713864168, 7752.651130699132, 7851.725189618336, 7925.167857375008, 8415.200555947175, 8454.704085356983, 480.7139751847645, 518.5592246590444, 548.3556820735699, 551.9586031047687, 572.0561074227475, 3900.5124359455067, 4083.652889504366, 4308.9569104309185, 4403.911921761547, 4439.66702497314, 63371.0, 63683.681581592726, 64131.83143095684, 64242.35757642457, 64970.675146623966, 57070.71464642733, 58169.0, 58567.41432585705, 59588.0, 60394.0, 50209.49790502121, 51861.48138518717, 52990.47009529932, 53494.732526337895, 53866.730666347205, 8177.386695997705, 8515.957420212859, 8546.572671366532, 8571.828563428571, 8644.91355086441, 35341.82329088338, 35345.646543535266, 35455.0, 35986.0, 37219.0, 44680.0, 45505.317420239386, 49096.01807963749, 49278.0, 51466.74266628643, 11007.174461915549, 11036.558537658724, 11062.778744425228, 11209.271397359145, 11562.653120406401, 12539.435725392197, 12553.93723031379, 12699.492020319083, 12805.743885122432, 13001.544945926848, 11994.460249288977, 12182.512699491921, 12221.572244971383, 12309.69225769327, 12942.223466592035, 11601.0, 11734.530618775154, 12075.335856527976, 12083.697907552381, 12212.511499540275, 11888.0, 11979.760404791681, 12090.153689241668, 12477.438515266653, 12661.87338126607, 8829.69096081634, 9234.722958311262, 9530.094641009093, 9671.758206044906, 10261.846072308772, 8654.740357789276, 9619.837179774553, 10006.070316154157, 10012.053113388778, 10028.298461737582], "value": 6257.724687012171, "unit": "score"}], "name": "dromaeo_css", "value": 6142.6487894210595, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 115.0, 118.0, 117.0, 115.0, 115.0, 117.0, 116.0, 116.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 126.0, 165.0, 128.0, 128.0, 123.0, 124.0, 151.0, 131.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 162.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 102.0, 77.0, 76.0, 76.0, 76.0, 92.0, 76.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 127.0, 84.0, 85.0, 87.0, 105.0, 86.0, 85.0, 110.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 126.0], "value": 126.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 146.0, 146.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 66.0, 66.0, 67.0, 65.0, 67.0, 65.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 65.0, 68.0, 65.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 86.0, 84.0, 84.0, 85.0, 83.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 136.0, 167.0, 140.0, 133.0, 133.0, 134.0, 142.0, 180.0, 153.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 182.0, 178.0, 184.0, 179.0, 183.0, 177.0, 180.0, 178.0, 183.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 67.0, 71.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1569.8999999999999, "alertThreshold": 2.0}]} 12:54:50 INFO - Return code: 0 12:54:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:54:50 INFO - # TBPL SUCCESS # 12:54:50 INFO - Running post-action listener: _resource_record_post_action 12:54:50 INFO - [mozharness: 2016-12-20 20:54:50.403622Z] Finished run-tests step (success) 12:54:50 INFO - Running post-run listener: _resource_record_post_run 12:54:50 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 381288448; Read time: 0; Write time: 279284 12:54:50 INFO - TinderboxPrint: CPU usage
13.1% 12:54:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:54:50 INFO - TinderboxPrint: I/O write bytes / time
381,288,448 / 279,284 12:54:50 INFO - TinderboxPrint: CPU idle
8,325.1 (86.8%) 12:54:50 INFO - TinderboxPrint: CPU user
1,215.5 (12.7%) 12:54:50 INFO - TinderboxPrint: Swap in / out
0 / 0 12:54:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99823616; Read time: 0; Write time: 93956 12:54:50 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 281464832; Read time: 0; Write time: 185328 12:54:51 INFO - Running post-run listener: _upload_blobber_files 12:54:51 INFO - Blob upload gear active. 12:54:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:54:51 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 12:54:51 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:54:51 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:54:51 INFO - (blobuploader) - INFO - Open directory for files ... 12:54:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:54:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:54:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:54:52 INFO - (blobuploader) - INFO - Done attempting. 12:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:54:52 INFO - (blobuploader) - INFO - Done attempting. 12:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:54:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:54:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:54:57 INFO - (blobuploader) - INFO - Done attempting. 12:54:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:54:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:54:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:54:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:54:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:54:58 INFO - (blobuploader) - INFO - Done attempting. 12:54:58 INFO - (blobuploader) - INFO - Iteration through files over. 12:54:58 INFO - Return code: 0 12:54:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:54:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:54:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c86ba5e4fe55a05deb4e0794ab8810a1b85b5da7cdba7036a63792179127fbcd0e3f775e687d8d2c87b1d7c0e7ee3cce5bd14aa2ffff098e40f7b12a081b75c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b20e482a3b9368fa7c5ee2d290d5a0527c82abb33c426bef6f58342b76fa037948027283f8425022696d57dad0aecf9e86f4f27f9b16377c89ff75599ce75fbf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65a850ad62b909f2dde213056b05e1d8e7604f9012669f5fa4a96c7d2988e32fab6cb9faf6a5d849293eb84c09324791ce9900e005c0ef186cdc4011a8c29f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ac3cf6ad21df77444fb5bbf02d30f6ee52e0c2cf5af87a2a45ce2051c8ca9fdd6dc5b7ed350bb99651f977a65979833fe83ab4bdcb7ffc97cd48283d396c71e"} 12:54:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:54:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:54:58 INFO - Contents: 12:54:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c86ba5e4fe55a05deb4e0794ab8810a1b85b5da7cdba7036a63792179127fbcd0e3f775e687d8d2c87b1d7c0e7ee3cce5bd14aa2ffff098e40f7b12a081b75c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b20e482a3b9368fa7c5ee2d290d5a0527c82abb33c426bef6f58342b76fa037948027283f8425022696d57dad0aecf9e86f4f27f9b16377c89ff75599ce75fbf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65a850ad62b909f2dde213056b05e1d8e7604f9012669f5fa4a96c7d2988e32fab6cb9faf6a5d849293eb84c09324791ce9900e005c0ef186cdc4011a8c29f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ac3cf6ad21df77444fb5bbf02d30f6ee52e0c2cf5af87a2a45ce2051c8ca9fdd6dc5b7ed350bb99651f977a65979833fe83ab4bdcb7ffc97cd48283d396c71e"} 12:54:58 INFO - Running post-run listener: copy_logs_to_upload_dir 12:54:58 INFO - Copying logs to upload dir... 12:54:58 INFO - mkdir: /builds/slave/test/build/upload/logs 12:54:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.202691 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-20 12:54:56.643441) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:56.648364) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c86ba5e4fe55a05deb4e0794ab8810a1b85b5da7cdba7036a63792179127fbcd0e3f775e687d8d2c87b1d7c0e7ee3cce5bd14aa2ffff098e40f7b12a081b75c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b20e482a3b9368fa7c5ee2d290d5a0527c82abb33c426bef6f58342b76fa037948027283f8425022696d57dad0aecf9e86f4f27f9b16377c89ff75599ce75fbf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65a850ad62b909f2dde213056b05e1d8e7604f9012669f5fa4a96c7d2988e32fab6cb9faf6a5d849293eb84c09324791ce9900e005c0ef186cdc4011a8c29f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ac3cf6ad21df77444fb5bbf02d30f6ee52e0c2cf5af87a2a45ce2051c8ca9fdd6dc5b7ed350bb99651f977a65979833fe83ab4bdcb7ffc97cd48283d396c71e"} build_url:https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/Kk1lp-eqSjaXBj8pgXbQ1A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c86ba5e4fe55a05deb4e0794ab8810a1b85b5da7cdba7036a63792179127fbcd0e3f775e687d8d2c87b1d7c0e7ee3cce5bd14aa2ffff098e40f7b12a081b75c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b20e482a3b9368fa7c5ee2d290d5a0527c82abb33c426bef6f58342b76fa037948027283f8425022696d57dad0aecf9e86f4f27f9b16377c89ff75599ce75fbf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65a850ad62b909f2dde213056b05e1d8e7604f9012669f5fa4a96c7d2988e32fab6cb9faf6a5d849293eb84c09324791ce9900e005c0ef186cdc4011a8c29f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ac3cf6ad21df77444fb5bbf02d30f6ee52e0c2cf5af87a2a45ce2051c8ca9fdd6dc5b7ed350bb99651f977a65979833fe83ab4bdcb7ffc97cd48283d396c71e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:56.676327) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:56.676876) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1482263332.191938-1051356169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 12:54:56.759054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 12:54:56.759391) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 12:54:56.759690) ========= ========= Total master_lag: 0.20 =========