builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1481733009.55 results: success (0) buildid: 20161214074201 builduid: d9ffc0d0c1d44bcdbf32861523aa6d6f revision: 18b5a7a5d833f09b1f1e5cc45f4c0ff6235a1d5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:09.554829) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:09.555298) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:09.555606) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:09.571626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:09.572094) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-14 08:30:09-- 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% 46.1M=0s 2016-12-14 08:30:09 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110901 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:09.696757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:09.697069) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015003 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:09.747962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 08:30:09.748325) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 18b5a7a5d833f09b1f1e5cc45f4c0ff6235a1d5e --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 18b5a7a5d833f09b1f1e5cc45f4c0ff6235a1d5e --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=9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-14 08:30:10,064 truncating revision to first 12 chars 2016-12-14 08:30:10,064 Setting DEBUG logging. 2016-12-14 08:30:10,064 attempt 1/10 2016-12-14 08:30:10,064 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/18b5a7a5d833?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 08:30:11,054 unpacking tar archive at: mozilla-central-18b5a7a5d833/testing/mozharness/ program finished with exit code 0 elapsedTime=1.301681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 08:30:11.064937) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:11.065463) ========= script_repo_revision: 18b5a7a5d833f09b1f1e5cc45f4c0ff6235a1d5e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:11.066088) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:11.066506) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:30:11.078606) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-12-14 08:30:11.079103) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:30:11 INFO - MultiFileLogger online at 20161214 08:30:11 in /builds/slave/test 08:30:11 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 08:30:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:30:11 INFO - {'append_to_log': False, 08:30:11 INFO - 'base_work_dir': '/builds/slave/test', 08:30:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:30:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:30:11 INFO - 'branch': 'Firefox-Non-PGO', 08:30:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:30:11 INFO - 'config_files': ('talos/linux_config.py',), 08:30:11 INFO - 'default_actions': ('clobber', 08:30:11 INFO - 'read-buildbot-config', 08:30:11 INFO - 'download-and-extract', 08:30:11 INFO - 'populate-webroot', 08:30:11 INFO - 'create-virtualenv', 08:30:11 INFO - 'install', 08:30:11 INFO - 'run-tests'), 08:30:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:30:11 INFO - 'download_minidump_stackwalk': True, 08:30:11 INFO - 'download_symbols': 'ondemand', 08:30:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:30:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:30:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:30:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:30:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:30:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:30:11 INFO - 'installer_path': 'installer.exe', 08:30:11 INFO - 'log_level': 'info', 08:30:11 INFO - 'log_name': 'talos', 08:30:11 INFO - 'log_to_console': True, 08:30:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:30:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:30:11 INFO - 'opt_config_files': (), 08:30:11 INFO - 'pip_index': False, 08:30:11 INFO - 'sps_profile': False, 08:30:11 INFO - 'sps_profile_interval': 0, 08:30:11 INFO - 'suite': 'dromaeojs', 08:30:11 INFO - 'system_bits': '32', 08:30:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:30:11 INFO - 'title': 'talos-linux64-ix-013', 08:30:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:30:11 INFO - 'use_talos_json': True, 08:30:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:30:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:30:11 INFO - 'work_dir': 'build'} 08:30:11 INFO - [mozharness: 2016-12-14 16:30:11.481965Z] Running clobber step. 08:30:11 INFO - Running pre-action listener: _resource_record_pre_action 08:30:11 INFO - Running main action method: clobber 08:30:11 INFO - rmtree: /builds/slave/test/build 08:30:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:30:11 INFO - Running post-action listener: _resource_record_post_action 08:30:11 INFO - [mozharness: 2016-12-14 16:30:11.992192Z] Finished clobber step (success) 08:30:11 INFO - [mozharness: 2016-12-14 16:30:11.992291Z] Running read-buildbot-config step. 08:30:11 INFO - Running pre-action listener: _resource_record_pre_action 08:30:11 INFO - Running main action method: read_buildbot_config 08:30:11 INFO - Using buildbot properties: 08:30:11 INFO - { 08:30:11 INFO - "project": "", 08:30:11 INFO - "product": "firefox", 08:30:11 INFO - "script_repo_revision": "production", 08:30:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:30:11 INFO - "repository": "", 08:30:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:30:11 INFO - "buildid": "20161214074201", 08:30:11 INFO - "pgo_build": "False", 08:30:11 INFO - "basedir": "/builds/slave/test", 08:30:11 INFO - "buildnumber": 343, 08:30:11 INFO - "slavename": "talos-linux64-ix-013", 08:30:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:30:11 INFO - "platform": "ubuntu64_hw", 08:30:11 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:30:11 INFO - "branch": "mozilla-central", 08:30:11 INFO - "repo_path": "mozilla-central", 08:30:11 INFO - "revision": "18b5a7a5d833f09b1f1e5cc45f4c0ff6235a1d5e", 08:30:11 INFO - "stage_platform": "linux64", 08:30:11 INFO - "builduid": "d9ffc0d0c1d44bcdbf32861523aa6d6f", 08:30:11 INFO - "slavebuilddir": "test" 08:30:11 INFO - } 08:30:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:30:11 INFO - Running post-action listener: _resource_record_post_action 08:30:11 INFO - [mozharness: 2016-12-14 16:30:11.994752Z] Finished read-buildbot-config step (success) 08:30:11 INFO - [mozharness: 2016-12-14 16:30:11.994839Z] Running download-and-extract step. 08:30:11 INFO - Running pre-action listener: _resource_record_pre_action 08:30:11 INFO - Running main action method: download_and_extract 08:30:11 INFO - mkdir: /builds/slave/test/build/tests 08:30:11 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')]} 08:30:11 INFO - trying https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:30:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/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 08:30:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/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 08:30:12 INFO - Downloaded 1361 bytes. 08:30:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:30:12 INFO - Using the following test package requirements: 08:30:12 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:30:12 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:30:12 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:30:12 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:12 INFO - u'jsshell-linux-x86_64.zip'], 08:30:12 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:30:12 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:30:12 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:30:12 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:30:12 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:30:12 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:30:12 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:30:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:30:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:30:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:30:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:30:13 INFO - Expected file size: 20212162 08:30:13 INFO - Obtained file size: 20212162 08:30: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 08:30:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:30:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:30:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:30:18 INFO - Expected file size: 20212162 08:30:18 INFO - Obtained file size: 20212162 08:30:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:30:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:30:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:30:23 INFO - Expected file size: 14409734 08:30:23 INFO - Obtained file size: 14409734 08:30: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')]} 08:30:23 INFO - trying https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:30:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/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 08:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/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 08:30:24 INFO - Downloaded 55778834 bytes. 08:30:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:30:24 INFO - mkdir: /builds/slave/test/properties 08:30:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:30:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:30:24 INFO - Contents: 08:30:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:30:25 INFO - Running post-action listener: _resource_record_post_action 08:30:25 INFO - Running post-action listener: set_extra_try_arguments 08:30:25 INFO - [mozharness: 2016-12-14 16:30:25.392558Z] Finished download-and-extract step (success) 08:30:25 INFO - [mozharness: 2016-12-14 16:30:25.392784Z] Running populate-webroot step. 08:30:25 INFO - Running pre-action listener: _resource_record_pre_action 08:30:25 INFO - Running main action method: populate_webroot 08:30:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:30:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:30:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:30:25 INFO - '--tppagecycles', 08:30:25 INFO - '7'], 08:30:25 INFO - 'tests': ['tsvgm']}}, 08:30:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:30:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:30:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:30:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:30:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:30:25 INFO - 'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:30:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:30:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:30:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:30:25 INFO - 'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['damp', 'tps']}, 08:30:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:30:25 INFO - 'tests': ['damp', 'tps']}, 08:30:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['dromaeo_dom']}, 08:30:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:30:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['basic_compositor_video']}, 08:30:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:30:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['a11yr', 08:30:25 INFO - 'ts_paint', 08:30:25 INFO - 'tpaint', 08:30:25 INFO - 'sessionrestore', 08:30:25 INFO - 'sessionrestore_no_auto_restore', 08:30:25 INFO - 'tabpaint']}, 08:30:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:30:25 INFO - 'ts_paint', 08:30:25 INFO - 'tpaint', 08:30:25 INFO - 'sessionrestore', 08:30:25 INFO - 'sessionrestore_no_auto_restore', 08:30:25 INFO - 'tabpaint']}, 08:30:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:30:25 INFO - 'ts_paint', 08:30:25 INFO - 'tpaint', 08:30:25 INFO - 'sessionrestore', 08:30:25 INFO - 'sessionrestore_no_auto_restore', 08:30:25 INFO - 'tabpaint']}, 08:30:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:30:25 INFO - 'ts_paint', 08:30:25 INFO - 'tpaint', 08:30:25 INFO - 'sessionrestore', 08:30:25 INFO - 'sessionrestore_no_auto_restore', 08:30:25 INFO - 'tabpaint']}, 08:30:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['a11yr', 08:30:25 INFO - 'ts_paint', 08:30:25 INFO - 'tpaint', 08:30:25 INFO - 'sessionrestore', 08:30:25 INFO - 'sessionrestore_no_auto_restore', 08:30:25 INFO - 'tabpaint']}, 08:30:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['a11yr', 08:30:25 INFO - 'ts_paint', 08:30:25 INFO - 'tpaint', 08:30:25 INFO - 'sessionrestore', 08:30:25 INFO - 'sessionrestore_no_auto_restore', 08:30:25 INFO - 'tabpaint']}, 08:30:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['tsvgx', 08:30:25 INFO - 'tsvgr_opacity', 08:30:25 INFO - 'tart', 08:30:25 INFO - 'tscrollx', 08:30:25 INFO - 'cart', 08:30:25 INFO - 'tsvg_static']}, 08:30:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:30:25 INFO - 'tsvgr_opacity', 08:30:25 INFO - 'tart', 08:30:25 INFO - 'tscrollx', 08:30:25 INFO - 'cart', 08:30:25 INFO - 'tsvg_static']}, 08:30:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:30:25 INFO - 'talos_options': ['--disable-e10s'], 08:30:25 INFO - 'tests': ['tp5o']}, 08:30:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:30:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:30:25 INFO - 'talos_options': ['--disable-e10s', 08:30:25 INFO - '--xperf_path', 08:30:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:25 INFO - 'tests': ['tp5n']}, 08:30:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:30:25 INFO - 'talos_options': ['--xperf_path', 08:30:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:25 INFO - 'tests': ['tp5n']}}, 08:30:25 INFO - 'talos.zip': {'path': '', 08:30:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:30:25 INFO - Running post-action listener: _resource_record_post_action 08:30:25 INFO - [mozharness: 2016-12-14 16:30:25.408818Z] Finished populate-webroot step (success) 08:30:25 INFO - [mozharness: 2016-12-14 16:30:25.408906Z] Running create-virtualenv step. 08:30:25 INFO - Running pre-action listener: _resource_record_pre_action 08:30:25 INFO - Running main action method: create_virtualenv 08:30:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:30: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 08:30:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:30:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:30:25 INFO - Using real prefix '/usr' 08:30:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:30:26 INFO - Installing distribute.............................................................................................................................................................................................done. 08:30:27 INFO - Installing pip.................done. 08:30:28 INFO - Return code: 0 08:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:30:28 INFO - Reading from file tmpfile_stdout 08:30:28 INFO - Output received: 08:30: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) 08:30:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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 0x7fa9cc122e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e51120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', '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 08:30: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 08:30: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 08:30:28 INFO - Using env: {'DISPLAY': ':0', 08:30:28 INFO - 'HOME': '/home/cltbld', 08:30:28 INFO - 'LANG': 'en_US.UTF-8', 08:30:28 INFO - 'LANGUAGE': 'en_US:en', 08:30:28 INFO - 'LOGNAME': 'cltbld', 08:30:28 INFO - 'MAIL': '/var/mail/cltbld', 08:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:28 INFO - 'MOZ_NO_REMOTE': '1', 08:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:28 INFO - 'NO_EM_RESTART': '1', 08:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:28 INFO - 'PWD': '/builds/slave/test', 08:30:28 INFO - 'SHELL': '/bin/bash', 08:30:28 INFO - 'SHLVL': '1', 08:30:28 INFO - 'TERM': 'linux', 08:30:28 INFO - 'TMOUT': '86400', 08:30:28 INFO - 'USER': 'cltbld', 08:30:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:28 INFO - '_': '/tools/buildbot/bin/python'} 08:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30: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 08:30:28 INFO - Cleaning up... 08:30:28 INFO - Return code: 0 08:30:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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 0x7fa9cc122e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e51120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', '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 08:30: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 08:30: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 08:30:28 INFO - Using env: {'DISPLAY': ':0', 08:30:28 INFO - 'HOME': '/home/cltbld', 08:30:28 INFO - 'LANG': 'en_US.UTF-8', 08:30:28 INFO - 'LANGUAGE': 'en_US:en', 08:30:28 INFO - 'LOGNAME': 'cltbld', 08:30:28 INFO - 'MAIL': '/var/mail/cltbld', 08:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:28 INFO - 'MOZ_NO_REMOTE': '1', 08:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:28 INFO - 'NO_EM_RESTART': '1', 08:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:28 INFO - 'PWD': '/builds/slave/test', 08:30:28 INFO - 'SHELL': '/bin/bash', 08:30:28 INFO - 'SHLVL': '1', 08:30:28 INFO - 'TERM': 'linux', 08:30:28 INFO - 'TMOUT': '86400', 08:30:28 INFO - 'USER': 'cltbld', 08:30:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:28 INFO - '_': '/tools/buildbot/bin/python'} 08:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:28 INFO - Downloading/unpacking psutil>=3.1.1 08:30:28 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 08:30:28 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 08:30:28 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 08:30:28 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 08:30:28 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 08:30:28 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 08:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:30:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:30:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:30:30 INFO - Installing collected packages: psutil 08:30:30 INFO - Running setup.py install for psutil 08:30:30 INFO - building 'psutil._psutil_linux' extension 08:30:30 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 08:30:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:30:30 INFO - building 'psutil._psutil_posix' extension 08:30:30 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 08:30: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 08:30:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:30:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:30:31 INFO - Successfully installed psutil 08:30:31 INFO - Cleaning up... 08:30:31 INFO - Return code: 0 08:30:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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 0x7fa9cc122e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e51120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', '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 08:30: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 08:30: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 08:30:31 INFO - Using env: {'DISPLAY': ':0', 08:30:31 INFO - 'HOME': '/home/cltbld', 08:30:31 INFO - 'LANG': 'en_US.UTF-8', 08:30:31 INFO - 'LANGUAGE': 'en_US:en', 08:30:31 INFO - 'LOGNAME': 'cltbld', 08:30:31 INFO - 'MAIL': '/var/mail/cltbld', 08:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:31 INFO - 'MOZ_NO_REMOTE': '1', 08:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:31 INFO - 'NO_EM_RESTART': '1', 08:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:31 INFO - 'PWD': '/builds/slave/test', 08:30:31 INFO - 'SHELL': '/bin/bash', 08:30:31 INFO - 'SHLVL': '1', 08:30:31 INFO - 'TERM': 'linux', 08:30:31 INFO - 'TMOUT': '86400', 08:30:31 INFO - 'USER': 'cltbld', 08:30:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:31 INFO - '_': '/tools/buildbot/bin/python'} 08:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:30:33 INFO - Installing collected packages: mozsystemmonitor 08:30:33 INFO - Running setup.py install for mozsystemmonitor 08:30:33 INFO - Successfully installed mozsystemmonitor 08:30:33 INFO - Cleaning up... 08:30:33 INFO - Return code: 0 08:30:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:30:33 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')]} 08:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:33 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')]} 08:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:33 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 0x7fa9cc122e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e51120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', '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 08:30:33 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 08:30:33 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 08:30:33 INFO - Using env: {'DISPLAY': ':0', 08:30:33 INFO - 'HOME': '/home/cltbld', 08:30:33 INFO - 'LANG': 'en_US.UTF-8', 08:30:33 INFO - 'LANGUAGE': 'en_US:en', 08:30:33 INFO - 'LOGNAME': 'cltbld', 08:30:33 INFO - 'MAIL': '/var/mail/cltbld', 08:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:33 INFO - 'MOZ_NO_REMOTE': '1', 08:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:33 INFO - 'NO_EM_RESTART': '1', 08:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:33 INFO - 'PWD': '/builds/slave/test', 08:30:33 INFO - 'SHELL': '/bin/bash', 08:30:33 INFO - 'SHLVL': '1', 08:30:33 INFO - 'TERM': 'linux', 08:30:33 INFO - 'TMOUT': '86400', 08:30:33 INFO - 'USER': 'cltbld', 08:30:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:33 INFO - '_': '/tools/buildbot/bin/python'} 08:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:33 INFO - Downloading/unpacking jsonschema==2.5.1 08:30:33 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 08:30:33 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 08:30:33 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 08:30:33 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 08:30:33 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 08:30:33 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 08:30:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:30:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:30:36 INFO - warning: no files found matching '*.txt' 08:30:36 INFO - no previously-included directories found matching 'build' 08:30:36 INFO - no previously-included directories found matching 'dist' 08:30:36 INFO - no previously-included directories found matching '.git*' 08:30:36 INFO - Installing collected packages: jsonschema, functools32 08:30:36 INFO - Running setup.py install for functools32 08:30:36 INFO - warning: no files found matching '*.txt' 08:30:36 INFO - no previously-included directories found matching 'build' 08:30:36 INFO - no previously-included directories found matching 'dist' 08:30:36 INFO - no previously-included directories found matching '.git*' 08:30:36 INFO - Successfully installed jsonschema functools32 08:30:36 INFO - Cleaning up... 08:30:36 INFO - Return code: 0 08:30:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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 0x7fa9cc122e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e51120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', '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 08:30: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 08:30: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 08:30:36 INFO - Using env: {'DISPLAY': ':0', 08:30:36 INFO - 'HOME': '/home/cltbld', 08:30:36 INFO - 'LANG': 'en_US.UTF-8', 08:30:36 INFO - 'LANGUAGE': 'en_US:en', 08:30:36 INFO - 'LOGNAME': 'cltbld', 08:30:36 INFO - 'MAIL': '/var/mail/cltbld', 08:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:36 INFO - 'MOZ_NO_REMOTE': '1', 08:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:36 INFO - 'NO_EM_RESTART': '1', 08:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:36 INFO - 'PWD': '/builds/slave/test', 08:30:36 INFO - 'SHELL': '/bin/bash', 08:30:36 INFO - 'SHLVL': '1', 08:30:36 INFO - 'TERM': 'linux', 08:30:36 INFO - 'TMOUT': '86400', 08:30:36 INFO - 'USER': 'cltbld', 08:30:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:36 INFO - '_': '/tools/buildbot/bin/python'} 08:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:30:36 INFO - Cleaning up... 08:30:36 INFO - Return code: 0 08:30:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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', '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 0x7fa9cc122e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e51120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', '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 08:30: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:30: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 blobuploader==1.2.4 08:30:36 INFO - Using env: {'DISPLAY': ':0', 08:30:36 INFO - 'HOME': '/home/cltbld', 08:30:36 INFO - 'LANG': 'en_US.UTF-8', 08:30:36 INFO - 'LANGUAGE': 'en_US:en', 08:30:36 INFO - 'LOGNAME': 'cltbld', 08:30:36 INFO - 'MAIL': '/var/mail/cltbld', 08:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:36 INFO - 'MOZ_NO_REMOTE': '1', 08:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:36 INFO - 'NO_EM_RESTART': '1', 08:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:36 INFO - 'PWD': '/builds/slave/test', 08:30:36 INFO - 'SHELL': '/bin/bash', 08:30:36 INFO - 'SHLVL': '1', 08:30:36 INFO - 'TERM': 'linux', 08:30:36 INFO - 'TMOUT': '86400', 08:30:36 INFO - 'USER': 'cltbld', 08:30:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:36 INFO - '_': '/tools/buildbot/bin/python'} 08:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:30:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:30:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30:39 INFO - Downloading docopt-0.6.1.tar.gz 08:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:30:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:30:39 INFO - Running setup.py install for blobuploader 08:30:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:30:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:30:39 INFO - Running setup.py install for requests 08:30:40 INFO - Running setup.py install for docopt 08:30:40 INFO - Successfully installed blobuploader requests docopt 08:30:40 INFO - Cleaning up... 08:30:40 INFO - Return code: 0 08:30:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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 0x7fa9cc122e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e51120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', '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 08:30: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 08:30: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 08:30:40 INFO - Using env: {'DISPLAY': ':0', 08:30:40 INFO - 'HOME': '/home/cltbld', 08:30:40 INFO - 'LANG': 'en_US.UTF-8', 08:30:40 INFO - 'LANGUAGE': 'en_US:en', 08:30:40 INFO - 'LOGNAME': 'cltbld', 08:30:40 INFO - 'MAIL': '/var/mail/cltbld', 08:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:40 INFO - 'MOZ_NO_REMOTE': '1', 08:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:40 INFO - 'NO_EM_RESTART': '1', 08:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:40 INFO - 'PWD': '/builds/slave/test', 08:30:40 INFO - 'SHELL': '/bin/bash', 08:30:40 INFO - 'SHLVL': '1', 08:30:40 INFO - 'TERM': 'linux', 08:30:40 INFO - 'TMOUT': '86400', 08:30:40 INFO - 'USER': 'cltbld', 08:30:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:40 INFO - '_': '/tools/buildbot/bin/python'} 08:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:40 INFO - Running setup.py (path:/tmp/pip-H2q9CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:40 INFO - Running setup.py (path:/tmp/pip-ygTZ_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:40 INFO - Running setup.py (path:/tmp/pip-1fyt41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:40 INFO - Running setup.py (path:/tmp/pip-UzlWKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:40 INFO - Running setup.py (path:/tmp/pip-Mdc1Q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:40 INFO - Running setup.py (path:/tmp/pip-VoD12c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:40 INFO - Running setup.py (path:/tmp/pip-Iqi4xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:41 INFO - Running setup.py (path:/tmp/pip-vaUgA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:41 INFO - Running setup.py (path:/tmp/pip-CAG3cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:41 INFO - Running setup.py (path:/tmp/pip-4TZjMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:41 INFO - Running setup.py (path:/tmp/pip-Iwoh_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:41 INFO - Running setup.py (path:/tmp/pip-61h2iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:41 INFO - Running setup.py (path:/tmp/pip-PRdN5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:41 INFO - Running setup.py (path:/tmp/pip-P8tvhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:41 INFO - Running setup.py (path:/tmp/pip-JbecjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:41 INFO - Running setup.py (path:/tmp/pip-vgdzD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:41 INFO - Running setup.py (path:/tmp/pip-FWEvgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:30:41 INFO - Running setup.py install for manifestparser 08:30:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:30:41 INFO - Running setup.py install for mozcrash 08:30:41 INFO - Running setup.py install for mozdebug 08:30:42 INFO - Running setup.py install for mozdevice 08:30:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:30:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:30:42 INFO - Running setup.py install for mozfile 08:30:42 INFO - Running setup.py install for mozhttpd 08:30:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:30:42 INFO - Running setup.py install for mozinfo 08:30:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:30:42 INFO - Running setup.py install for mozInstall 08:30:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:30:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:30:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:30:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:30:42 INFO - Running setup.py install for mozleak 08:30:42 INFO - Running setup.py install for mozlog 08:30:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:30:42 INFO - Running setup.py install for moznetwork 08:30:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:30:42 INFO - Running setup.py install for mozprocess 08:30:42 INFO - Running setup.py install for mozprofile 08:30:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:30:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:30:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:30:43 INFO - Running setup.py install for mozrunner 08:30:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:30:43 INFO - Running setup.py install for mozscreenshot 08:30:43 INFO - Running setup.py install for moztest 08:30:43 INFO - Running setup.py install for mozversion 08:30:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:30:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:30:43 INFO - Cleaning up... 08:30:43 INFO - Return code: 0 08:30:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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 0x7fa9cc122e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e51120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', '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 08:30: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 08:30: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 08:30:43 INFO - Using env: {'DISPLAY': ':0', 08:30:43 INFO - 'HOME': '/home/cltbld', 08:30:43 INFO - 'LANG': 'en_US.UTF-8', 08:30:43 INFO - 'LANGUAGE': 'en_US:en', 08:30:43 INFO - 'LOGNAME': 'cltbld', 08:30:43 INFO - 'MAIL': '/var/mail/cltbld', 08:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:43 INFO - 'MOZ_NO_REMOTE': '1', 08:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:43 INFO - 'NO_EM_RESTART': '1', 08:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:43 INFO - 'PWD': '/builds/slave/test', 08:30:43 INFO - 'SHELL': '/bin/bash', 08:30:43 INFO - 'SHLVL': '1', 08:30:43 INFO - 'TERM': 'linux', 08:30:43 INFO - 'TMOUT': '86400', 08:30:43 INFO - 'USER': 'cltbld', 08:30:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:43 INFO - '_': '/tools/buildbot/bin/python'} 08:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:43 INFO - Running setup.py (path:/tmp/pip-19qd_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:43 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)) 08:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:43 INFO - Running setup.py (path:/tmp/pip-H20v0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:43 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)) 08:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:43 INFO - Running setup.py (path:/tmp/pip-ZXC_DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30: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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:44 INFO - Running setup.py (path:/tmp/pip-9ayEj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30: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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:44 INFO - Running setup.py (path:/tmp/pip-OheCik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30: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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:44 INFO - Running setup.py (path:/tmp/pip-5g3UqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30: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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:44 INFO - Running setup.py (path:/tmp/pip-w2sUx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30: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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:44 INFO - Running setup.py (path:/tmp/pip-jtnqam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30: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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:44 INFO - Running setup.py (path:/tmp/pip-Ko_d_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30: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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:44 INFO - Running setup.py (path:/tmp/pip-vFWBFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30: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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:44 INFO - Running setup.py (path:/tmp/pip-JyQISg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30: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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:44 INFO - Running setup.py (path:/tmp/pip-UA7D2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:44 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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:44 INFO - Running setup.py (path:/tmp/pip-EPcWQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:44 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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:44 INFO - Running setup.py (path:/tmp/pip-aTWv45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:44 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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:44 INFO - Running setup.py (path:/tmp/pip-pPUZxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:44 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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:44 INFO - Running setup.py (path:/tmp/pip-lk9vA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:44 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)) 08:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:44 INFO - Running setup.py (path:/tmp/pip-xHdnt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30: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)) 08:30: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)) 08:30: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)) 08:30: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)) 08:30: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)) 08:30: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)) 08:30:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30:47 INFO - Downloading blessings-1.6.tar.gz 08:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:30:47 INFO - Installing collected packages: blessings 08:30:47 INFO - Running setup.py install for blessings 08:30:47 INFO - Successfully installed blessings 08:30:47 INFO - Cleaning up... 08:30:47 INFO - Return code: 0 08:30:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:30:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:47 INFO - Reading from file tmpfile_stdout 08:30:47 INFO - Current package versions: 08:30:47 INFO - argparse == 1.2.1 08:30:47 INFO - blessings == 1.6 08:30:47 INFO - blobuploader == 1.2.4 08:30:47 INFO - docopt == 0.6.1 08:30:47 INFO - functools32 == 3.2.3-2 08:30:47 INFO - jsonschema == 2.5.1 08:30:47 INFO - manifestparser == 1.1 08:30:47 INFO - mozInstall == 1.12 08:30:47 INFO - mozcrash == 1.0 08:30:47 INFO - mozdebug == 0.1 08:30:47 INFO - mozdevice == 0.49 08:30:47 INFO - mozfile == 1.2 08:30:47 INFO - mozhttpd == 0.7 08:30:47 INFO - mozinfo == 0.9 08:30:47 INFO - mozleak == 0.1 08:30:47 INFO - mozlog == 3.4 08:30:47 INFO - moznetwork == 0.27 08:30:47 INFO - mozprocess == 0.23 08:30:47 INFO - mozprofile == 0.28 08:30:47 INFO - mozrunner == 6.13 08:30:47 INFO - mozscreenshot == 0.1 08:30:47 INFO - mozsystemmonitor == 0.3 08:30:47 INFO - moztest == 0.7 08:30:47 INFO - mozversion == 1.4 08:30:47 INFO - psutil == 3.1.1 08:30:47 INFO - requests == 1.2.3 08:30:47 INFO - wsgiref == 0.1.2 08:30:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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 0x7fa9cc122e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e51120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', '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 08:30: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 08:30: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 08:30:47 INFO - Using env: {'DISPLAY': ':0', 08:30:47 INFO - 'HOME': '/home/cltbld', 08:30:47 INFO - 'LANG': 'en_US.UTF-8', 08:30:47 INFO - 'LANGUAGE': 'en_US:en', 08:30:47 INFO - 'LOGNAME': 'cltbld', 08:30:47 INFO - 'MAIL': '/var/mail/cltbld', 08:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:47 INFO - 'MOZ_NO_REMOTE': '1', 08:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:47 INFO - 'NO_EM_RESTART': '1', 08:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:47 INFO - 'PWD': '/builds/slave/test', 08:30:47 INFO - 'SHELL': '/bin/bash', 08:30:47 INFO - 'SHLVL': '1', 08:30:47 INFO - 'TERM': 'linux', 08:30:47 INFO - 'TMOUT': '86400', 08:30:47 INFO - 'USER': 'cltbld', 08:30:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:47 INFO - '_': '/tools/buildbot/bin/python'} 08:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:47 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)) 08:30:47 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)) 08:30:47 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)) 08:30:47 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)) 08:30:47 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)) 08:30:47 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)) 08:30:47 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)) 08:30:47 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)) 08:30:47 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)) 08:30:47 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)) 08:30:47 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)) 08:30:47 INFO - Cleaning up... 08:30:47 INFO - Return code: 0 08:30:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:30: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')]} 08:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30: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')]} 08:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:47 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 0x7fa9cc122e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e51120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', '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 08:30:47 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 08:30:47 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 08:30:47 INFO - Using env: {'DISPLAY': ':0', 08:30:47 INFO - 'HOME': '/home/cltbld', 08:30:47 INFO - 'LANG': 'en_US.UTF-8', 08:30:47 INFO - 'LANGUAGE': 'en_US:en', 08:30:47 INFO - 'LOGNAME': 'cltbld', 08:30:47 INFO - 'MAIL': '/var/mail/cltbld', 08:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:47 INFO - 'MOZ_NO_REMOTE': '1', 08:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:47 INFO - 'NO_EM_RESTART': '1', 08:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:47 INFO - 'PWD': '/builds/slave/test', 08:30:47 INFO - 'SHELL': '/bin/bash', 08:30:47 INFO - 'SHLVL': '1', 08:30:47 INFO - 'TERM': 'linux', 08:30:47 INFO - 'TMOUT': '86400', 08:30:47 INFO - 'USER': 'cltbld', 08:30:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:47 INFO - '_': '/tools/buildbot/bin/python'} 08:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:30:47 INFO - Cleaning up... 08:30:47 INFO - Return code: 0 08:30:47 INFO - Running post-action listener: _resource_record_post_action 08:30:47 INFO - Running post-action listener: _start_resource_monitoring 08:30:47 INFO - Starting resource monitoring. 08:30:47 INFO - [mozharness: 2016-12-14 16:30:47.987017Z] Finished create-virtualenv step (success) 08:30:47 INFO - [mozharness: 2016-12-14 16:30:47.987533Z] Running install step. 08:30:47 INFO - Running pre-action listener: _resource_record_pre_action 08:30:47 INFO - Running main action method: install 08:30:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:48 INFO - Reading from file tmpfile_stdout 08:30:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:30:48 INFO - Reading from file tmpfile_stdout 08:30:48 INFO - Output received: 08:30:48 INFO - Usage: mozinstall [options] installer 08:30:48 INFO - Options: 08:30:48 INFO - -h, --help show this help message and exit 08:30:48 INFO - -d DEST, --destination=DEST 08:30:48 INFO - Directory to install application into. [default: 08:30:48 INFO - "/builds/slave/test"] 08:30:48 INFO - --app=APP Application being installed. [default: firefox] 08:30:48 INFO - mkdir: /builds/slave/test/build/application 08:30: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'] 08:30: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 08:31:04 INFO - Reading from file tmpfile_stdout 08:31:04 INFO - Output received: 08:31:04 INFO - /builds/slave/test/build/application/firefox/firefox 08:31:04 INFO - Running post-action listener: _resource_record_post_action 08:31:04 INFO - [mozharness: 2016-12-14 16:31:04.335366Z] Finished install step (success) 08:31:04 INFO - [mozharness: 2016-12-14 16:31:04.335609Z] Running run-tests step. 08:31:04 INFO - Running pre-action listener: _resource_record_pre_action 08:31:04 INFO - Running main action method: run_tests 08:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:31:04 INFO - Python 2.7.3 08:31:04 INFO - Return code: 0 08:31:04 INFO - grabbing minidump binary from tooltool 08:31: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')]} 08:31: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 0x1ee1f20>, '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 0x1e4ec20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4ef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:31: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 08:31: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 08:31: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 08:31:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:31:04 INFO - Return code: 0 08:31:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:31:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:31:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:31:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:31:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:31: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/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:31: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/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 08:31:04 INFO - Using env: {'DISPLAY': ':0', 08:31:04 INFO - 'HOME': '/home/cltbld', 08:31:04 INFO - 'LANG': 'en_US.UTF-8', 08:31:04 INFO - 'LANGUAGE': 'en_US:en', 08:31:04 INFO - 'LOGNAME': 'cltbld', 08:31:04 INFO - 'MAIL': '/var/mail/cltbld', 08:31:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:31:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:04 INFO - 'MOZ_NO_REMOTE': '1', 08:31:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:04 INFO - 'NO_EM_RESTART': '1', 08:31:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:04 INFO - 'PWD': '/builds/slave/test', 08:31:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:31:04 INFO - 'SHELL': '/bin/bash', 08:31:04 INFO - 'SHLVL': '1', 08:31:04 INFO - 'TERM': 'linux', 08:31:04 INFO - 'TMOUT': '86400', 08:31:04 INFO - 'USER': 'cltbld', 08:31:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743', 08:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:04 INFO - '_': '/tools/buildbot/bin/python'} 08:31: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/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:31:04 INFO - mozversion application_buildid: 20161214074201 08:31:04 INFO - mozversion application_changeset: 18b5a7a5d833f09b1f1e5cc45f4c0ff6235a1d5e 08:31:04 INFO - mozversion application_display_name: Nightly 08:31:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:31:04 INFO - mozversion application_name: Firefox 08:31:04 INFO - mozversion application_remotingname: firefox 08:31:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:31:04 INFO - mozversion application_vendor: Mozilla 08:31:04 INFO - mozversion application_version: 53.0a1 08:31:04 INFO - mozversion platform_buildid: 20161214074201 08:31:04 INFO - mozversion platform_changeset: 18b5a7a5d833f09b1f1e5cc45f4c0ff6235a1d5e 08:31:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:31:04 INFO - mozversion platform_version: 53.0a1 08:31:04 INFO - using testdate: 1481733064 08:31:04 INFO - actual date: 1481733064 08:31:04 INFO - starting webserver on 'localhost:58605' 08:31:04 INFO - SUITE-START | Running 2 tests 08:31:04 INFO - TEST-START | dromaeo_css 08:31:04 INFO - operating with platform_type : linux_ 08:31:04 INFO - Initialising browser for dromaeo_css test... 08:31:04 INFO - TEST-INFO | started process 6080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCJ0wFN/profile http://localhost:58605/getInfo.html) 08:31:08 INFO - PROCESS | 6080 | __metrics Screen width/height:1600/1200 08:31:08 INFO - PROCESS | 6080 | colorDepth:24 08:31:08 INFO - PROCESS | 6080 | Browser inner width/height: 1024/697 08:31:08 INFO - PROCESS | 6080 | __metrics 08:31:09 INFO - PROCESS | 6080 | 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" 08:31:09 INFO - PROCESS | 6080 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:31:10 INFO - PROCESS | 6080 | console.error: PushService: 08:31:10 INFO - PROCESS | 6080 | stateChangeProcessEnqueue: Error transitioning state 08:31:10 INFO - PROCESS | 6080 | UnknownError 08:31:10 INFO - TEST-INFO | 6080: exit 0 08:31:10 INFO - Browser initialized. 08:31:10 INFO - Running cycle 1/1 for dromaeo_css test... 08:31:10 INFO - TEST-INFO | started process 6164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCJ0wFN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:23 INFO - PROCESS | 6164 | RSS: Main: 173133824 08:31:23 INFO - PROCESS | 6164 | 08:32:14 INFO - PROCESS | 6164 | 1481733134350 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] 08:34:28 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:58605/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58605/tests/dromaeo/cssquery-ext.html) 08:34:29 INFO - PROCESS | 6164 | RSS: Main: 306114560 08:34:29 INFO - PROCESS | 6164 | 08:37:32 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:58605/tests/dromaeo/cssquery-ext.html (next: http://localhost:58605/tests/dromaeo/cssquery-jquery.html) 08:37:33 INFO - PROCESS | 6164 | RSS: Main: 280584192 08:37:33 INFO - PROCESS | 6164 | 08:40:35 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:58605/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58605/tests/dromaeo/cssquery-mootools.html) 08:40:36 INFO - PROCESS | 6164 | RSS: Main: 223956992 08:40:36 INFO - PROCESS | 6164 | 08:43:38 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:58605/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58605/tests/dromaeo/cssquery-prototype.html) 08:43:39 INFO - PROCESS | 6164 | RSS: Main: 239861760 08:43:39 INFO - PROCESS | 6164 | 08:46:42 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:58605/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58605/tests/dromaeo/cssquery-yui.html) 08:46:43 INFO - PROCESS | 6164 | RSS: Main: 224137216 08:46:43 INFO - PROCESS | 6164 | 08:49:46 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:58605/tests/dromaeo/cssquery-yui.html (next: http://localhost:58605/tests/dromaeo/cssquery-dojo.html) 08:49:46 INFO - PROCESS | 6164 | RSS: Main: 322478080 08:49:46 INFO - PROCESS | 6164 | 08:49:46 INFO - PROCESS | 6164 | __start_tp_report 08:49:46 INFO - PROCESS | 6164 | _x_x_mozilla_page_load 08:49:46 INFO - PROCESS | 6164 | _x_x_mozilla_page_load_details 08:49:46 INFO - PROCESS | 6164 | |i|pagename|runs| 08:49:46 INFO - PROCESS | 6164 | |0;dojo.html;2584.8836802343894;2621.501914636218;2642.0224516928733;2650.1651979626417;2659.002873922278;4633.976830115845;4676.275177347512;4700.482946875841;4718.551737584929;4725.929111063337;4657.976710116444;4689.929651055237;4704.905901881961;4723.409573803275;4790.664653474259;4270.231358355495;4323.913521729563;4332.24185767491;4337.848175313865;4342;4329.631981281579;4369.104333611618;4403.669724770639;4463.754493502856;4488.281874900017;4411.316245981862;4418.204723149832;4429.247028005247;4449.977750111245;4470.97764511177;4225.302825033866;4254.234237837188;4256.723312984646;4312.094460163369;4370.584794444522;4240.554741752102;4251.766152861592;4264.573542645741;4281.4648168978565;4339.370791235253;4653.813847446098;4659.650526210514;4666.626669866402;4678.555537223959;4714.080754252922;4913.975430122862;4985.451600323961;5010.273510341017;5017.172166592508;5059.443461219263;4991.450940396553;5028.899422011576;5037.974810125963;5051.494850514956;5054.974725126388;4728.030753695519;4755.0489902019735;4756.571908528249;4816.060868130751;4821.421429428421;5200.24596433515;5203.60972927032;5204.76578553966;5208.192730126836;5256.369235691665;5002.224655178453;5003.524665156804;5003.5997120230295;5004;5054.671446355975;4902.191138462185;4967.751612419364;4968.0312339093525;4969.031038947371;5023.34696489454;4942.555170034642;4943.357363542788;4944.233643785219;4970.751462426936;5008.549230569266;4925.679830810986;4935.654504184745;4935.7532123393685;4941.45643979162;4972.5027497249985;4203.47456567929;4285.7000009999;4289.699721019499;4305.117450922553;4338.197433474817;3760;3767.2088861339425;3786.7917264550715;3788.337041017866;3834.213986132836;4323.935140972888;4326.15639950213;4330.39374487572;4337.175936572041;4373.1472362888935;5073.315102461121;5079.415867175248;5080;5108;5125.436202017775;4214.620684138442;4234.110836724322;4239.236937351307;4306.633936115402;4330.891727706832;4608.331791890224;4608.9308660370125;4650.906981860411;4664.95335046652;4665.160271151225;4717.481077081518;4731.030138821602;4731.3612662291525;4732.171869922681;4774.045190961752;4911.312416261655;5080.161773307363;5081.364829396325;5083.72039537829;5131.974340128276;4611.446626404853;4683.461401938821;4702.083093796677;4734.6449016324605;4743.45450273223;4968.726720030289;4983.277424773315;5019.247112932943;5019.3976722793495;5021.799128034984;5018.573421259088;5032.6980381177245;5052.823151189691;5055.7219352935945;5056.216286475602;4757.714537127784;4788.928166077581;4863.610911127172;4932.630052745986;4965.851024469272;4833.347498087714;4902.4607293197005;4932.062908047459;4950.282209079735;4992.326035985241;4864.95135048645;4885.40829189362;4888.560029597211;4904.264360345834;4934.358533390637;4996.550310471929;4999.225120106389;4999.275105109666;5006.624503162205;5056.191009438472;4726.291056341576;4761.6904901181315;4768.3085952537385;4797.712137271775;4803.903921921612 08:49:46 INFO - PROCESS | 6164 | |1;ext.html;511.649520078746;548.1531034551617;553.3083645443196;560.277242357359;572.0475408444934;28131.859340703293;36917.44623830642;38766;38865.22269554607;42445.57554424455;40032.39951400732;40642.59357406425;40675.52569217384;40693.7965310173;40695.18609627813;7345.449091318146;7470.32767050964;7646.464747467679;7647.694092236332;7652.387808975269;7367.742129025485;9651.80696386072;9891.950540247324;9896.455694936776;10176.542055607515;9581.904180958205;9644.18024467921;9649.083337082966;9655.565499552502;9659;9735.610575576968;9772.853407198898;9826.213902887752;9829.803403931954;9848.90151098487;9689.079537443931;9761.07269809367;9762.853557196648;9766.755831104208;9768.804623907554;37800;38080.61919380799;38080.80959595212;38094.61905380939;38146;3059.571659967584;3087.5986121804244;3276.2955964467756;3287.3589650018257;3395.847186876572;28622.713772862215;28988.71011289902;29084;29205.561916571267;30315.696843031506;3160.9051728448185;3322.9169270768184;3386.5936087669393;3423.8288085595623;3491.2493813830147;201597;247492;248343;248921.9999999982;249414;46785.766071169426;47400.76299618549;47438.76280618575;47528.762356187995;47564.28653570199;49760.751196243786;49777.751111244215;49796.75101624541;49842.77594196917;49871.50128498668;11930.164888457899;12260.448279827251;12261.080418968613;12284.754304913851;12315.876841231653;8856.557172141367;8860.955695221483;10259.333143345659;10279.280450368551;10417.791644167075;15755.291011904492;15769.132697701507;15927.920360398355;15958.808238352376;16023.679526409407;6436.80689579304;6472.546921715435;6492.123563318986;6507.284198738135;6519.511036672268;745.7240820896303;842.7050532313641;895.8521843895684;945.2815859946353;945.4469135555639;26718.732812671624;27894.3026424341;28178.577321340195;28639.856800715865;28689.13932582026;909.417972497602;969.5782334684435;971.6404930175739;997.8453339732353;999.3803841618243;14015.85984140166;15037.624059398384;15055.623609409853;15371.231438428034;15372.615684607974;104780.47609761903;105038;105177;105192;105230.47384763027;50142.74928625333;50585.24122138171;50820;50836.23745643818;50937;1066.7066556696816;1078.7518870659949;1082.280283611421;1190.1966172833304;1199.4242763473408;26075.60886586665;28286.43427131487;28998.27504312409;31109.8444507776;31321.37357252888;47117;47768.761156194;47926.81097835213;48014;48068.27897581609;304131;306022;306438;307236;307261;22647.547049059256;23704.170354037527;23737;24960.625590615793;25006.874965625055;34384.312313753086;34847;34867.12832179216;34913.30173396467;35901;29387.85306073456;29570.260743481584;29648.110556683336;29992.5003749816;30919.69080309258;29136.56295155532;29337;29493.115206543836;30019.849900750356;30202.395952081275;29365.41269174562;30139.698603014567;30175.547366789076;30608.540871887384;30614.693853061184;25596.23211303664;27655.30861728473;27660.446791064467;27777.44445111046;28066.438671226868;21604;22105.226317078825;22247.55504889861;22339.553208936057;22398.32805015852 08:49:46 INFO - PROCESS | 6164 | |2;jquery.html;333.681334325719;350.22949511075626;359.2599245554158;364.40238009664154;377.8658576205447;12341.074419418546;12506.937465312662;13222.669433264173;13311.467541298349;16078.59803504913;15900.363985440568;16078.59803504913;16081.678366432665;16224.918875405607;16241.431549895757;4864.610831133509;5007.349044624194;5103.41310749263;5266.157414813631;5307.73461326934;5228.921566176491;5261.079311120558;5264.894702105956;5267.315249017623;5269;3420.4185288501017;3551.6093229744706;3597.964020359789;4958.231474121517;5242.9213561796605;5302.44324345942;5305.283786688806;5305.920411193835;5311.62818602698;5311.760970756325;5000.899982000376;5148.330717006766;5167.560757335631;5180.119379705459;5185.455527169631;11495.65513034602;11723.472443740053;11724.648260552198;15797.289121989537;18738.437846864617;1811.0944527736133;1882.4823173627226;1910.6274276515946;1939.2243102758869;2082.8958552072336;8146.5519396433765;8311.418200725951;8776.780580485474;8920.776980575472;9026.819463610756;1633.3793158599656;1640.75388691696;1672.540051485839;1700.1414285785722;1735.878488505805;64107.358926410605;65775;65805.01292480569;66921.33078669249;67328;9570.665026724031;9633.9036609633;9854.99462943076;9884.258680598983;9914.40513569188;13469.528566500125;13482;13496.797548036788;13507.459701612022;13538.93230533841;6811.897821532681;7202.387797037206;7237.384822290059;7318.670659820321;7448.664810083559;6867.828304292432;6904.206016308089;7092.5389849659605;7095.148582170069;7105.538140020882;3963.900902477461;4016.377461493473;4056.7565946043333;4091.8363265469643;4120.608542188487;1718.3556166437586;1739.4259894235124;1773.9976913044088;1796.2365994452566;1839.5125291797685;735.6983636708924;762.4357975098499;807.2250639386137;812.8049268175595;843.5149788871423;14772.113673179643;14807.185604791624;15082.396704131712;15385.384584616713;15722.842771572137;731.5829976913109;766.9271419215165;778.3267473635265;793.9920600794034;806.1897792718281;7968.243016913384;8264.586770661443;8301.086880443147;8368.079511253758;8700.30397568193;336947;337395;338363;342154.96598027344;347774;66091;66612.666936665;66876;67892.1740173784;72061.63969180225;870.564717641192;878.8769572259761;911.4212475078373;912.4160537256162;913.4199783137756;9464.432134071978;14086.718265634834;15068.321925513159;15089.396424142911;16598.502044938672;34015.829920850236;34041;35090.824545877105;35176;35437.82281088578;43709.34435983526;44482.777586111864;44589;50066;51300.48699512957;9602.711918642452;10317.535710892878;10385.63650272237;10809.189310801565;10841.566337346418;10308.793824123626;10632.149428045583;10939.507722152362;11369.602063927723;11750.412479376168;9417.434953902513;9488.95255523718;9888.604455821687;10317.896821031994;10529.842052369373;9960.800783984134;10029.749256268651;10074.244431667801;10123.696289111338;10161.491925403849;10241.692749217535;10358.326708763907;10359.482025898826;10395.896041039492;11005.449727513753;10197.932878407102;10300.484975751033;10398.012188842047;10701.304415212986;10854.18593605467;9708.951455242679;9797.363171393836;9943.154831839085;10018.899811001796;10435.530401131815 08:49:46 INFO - PROCESS | 6164 | |3;mootools.html;1287.9420426080826;1327.8472975607806;1403.8245219347582;1623.7970253718286;1661.3686799016373;6105.6947152642415;6334.3032266450655;6717.496187785917;7113.644317784109;7120.394766444845;6642.601443913369;6912.758053468129;6951.652417379136;7037.824054398642;7049.436045116391;2088.8120069193806;2118.6186486432434;2133.9039743211515;2134.6797980303;2139.6362618354838;1828.2778302570478;1891.432570228926;2069.317125348631;2096.6121267565472;2150.774168712286;2003.6794112941932;2098.8950552472393;2102.3272552783114;2109.9050542725536;2114.3022802475225;2052.8768273903465;2055.876647401153;2078.8544801863877;2081.791820817929;2086.7600225974056;2116.703661487393;2118.396257066744;2125.4048866317457;2146.549224662823;2149.4733790221494;6716.429103526158;6784.660766961632;6788.72845086196;7042.084529011247;7164.605946672931;4244.257254980366;4406.184855801687;4408.977955110204;4411.823527058914;4413.845515406977;2659.1091984185323;2717.9592306115424;2784.3456787654886;2786.289496178482;2791.6510436195476;869.1699427047218;869.3479890082439;872.3021582733787;874.3092956564307;884.5090974509145;9272.258219342504;9275;9289.071092890725;9292.674756383494;9297.72106836796;3800.220954704279;3894.8636797711943;3913.6086391360636;4069.04377471294;4075.572064933199;8087.595620218965;8098.75703728889;8099.595020248964;8103.716369927024;8107.986501687289;4376.518582955872;4377.846775362847;4381.583749543788;4386.232409328355;4388.824447022083;3959.5050618672667;4003.8398464061693;4004.5795191505053;4005.5794141615293;4008.6191811777835;3355.815430151365;3361.83190840457;3437.415639341318;3454.101933497309;3467.1678797088516;995.0994350113159;1033.0495943731635;1114.1755101225035;1139.3733446604335;1142.0749193153572;557.5511713071016;770.9768706938801;801.9318357939641;805.7743831727125;827.8385714785559;4801.303810947463;4856.95143048572;4863.659543831898;4867.878303042381;4895.216765317603;815.1603848036532;827.210014436212;849.9783270473526;853.9274161696326;887.454215657366;3329.916752081169;3336.5328853960464;3355.278615097766;3376.74674399421;3420.127867393848;8246.711365102192;8599.78500537479;8620.396572240008;8637.524936128573;8646.26506746921;8492.830143397097;8507.489550626982;8511.446755960842;8525.232729054414;8531;6641.634710090992;6652.268250492442;6652.368025037614;6741.831454213586;6774.661266936633;4676.134915040729;4783.95216047835;5041.168207245763;5136.203888397305;5205.401378841481;7731.690732370642;7738.535687858746;7790.493617914817;7804.336631386395;7823.2567906048835;7527.397808175442;7804.570748608654;7829;7935.920640793749;8011.959940200261;6184.81445556634;6325.399087086719;6331.620102793847;6339.144215531029;6358.141650877073;6465.127207826883;6518.315576864361;6519.41325280708;6519.771807986698;6532.248791388861;6037;6147.508199343953;6279.466245369194;6303.590266632654;6373.3945275198785;6142.447179753844;6157.815265542041;6205.348438414082;6242.250929888442;6255.155554000334;5801.535877129904;5878.764849406147;5878.941210587839;5879.882402352015;5924.140999554954;4148.419221309079;4175.436316097288;4213.683973701924;4258.8296468140925;4334.848280310174;4142;4167.8958026049595;4227.915441691211;4252.851150209728;4323.740575565476 08:49:46 INFO - PROCESS | 6164 | |4;prototype.html;336.68015385383893;338.2440246050078;347.9269353435778;350.9245512214873;351.6237625740459;4841.612670986321;4847.539483749047;4870.805167793288;4892.437369702481;4916.754162291889;4573.725576465406;4607.28587069004;4712.269598212282;4770.856874293768;4772.57046865782;3844.4041173618134;3858.672012878909;3859.864904728335;3870.2196989384915;3873.9418908716393;3855.4216867469822;3856.3636999894984;3862.1503269280715;3862.324093283678;3864.458975743384;3566.7324950628677;3605.7836529808164;3832.2910261601555;3862.1310205203886;3863.884083477486;3778.527684039495;3800.714946379019;3803.5245594300713;3811.3711237645757;3812.5424949006297;3447.4484082546674;3452.9654703452893;3460.2214501737158;3465.8267086645565;3480.547528821237;4680.812767489297;4689.601383882374;4712.835050773241;4720.3863497745415;4720.409948756405;4208.737378786383;4424.40270563473;4472.843450479218;4481.977590112061;4483.753393563353;5055.5702765265;5075.771590278409;5095.694258344474;5109.259157422191;5110.131277682765;3852.1525264442057;3854.5181852268465;3857.5341370279116;3859.3439115350457;3874.593167717377;5162.199859021857;5282.313299271109;5295.629305948585;5301.867453313621;5383.811566595189;3925.450436938831;3931.253061918226;3938.6455219030427;3944.467496887941;3945.2109578083923;3979.7413168143976;3988;4000;4006.6794656427414;4011.7592944423427;4290.485141782943;4431.423914891108;4468.687191896601;4487.147441986078;4504.301833215857;5048.722320272347;5053.747312634354;5071.822486212965;5077.8730531737;5113.258577506241;1340.4370164530922;1359.9256587296122;1363.9181649101085;1364.9830875997445;1367.924764137962;903.6927444668713;923.1691477670016;946.2004606107828;982.1308142293979;983.5050722901293;4207.873763787091;4237.470316210473;4251.553586873334;4254.553271906405;4258;5029.270755740397;5035.571976381975;5061.139606266944;5061.772220250024;5072.51811077947;4119.7940102994735;4252.851150209728;4289.742615443083;4294.527601963781;4295.8496452624;2656.641353417264;2676.9598456023177;2682.785377169822;2682.919512414631;2692.8384296942245;4623.653226008063;4676.784036150625;4686.859394218179;4691.437027556715;4696.8590942271785;4867.294242334841;5057.482755173433;5133.329669286478;5142.948570514322;5175.560077393388;4636.698614590041;4638.652101092432;4642.001969576557;4651.279051746985;4669.509701481364;4950.727709975986;4991.001799640014;5002.474740152377;5010.198368261061;5022.719206602293;4843.539863712942;4868.148074087091;4902.313676085422;4913.63147763912;5110.437851836221;4822.541858523435;4830.420349558076;4843.660943734046;4844.563989240985;4872.293517440023;3645.888004158651;3676.852925882935;3680.4847321374496;3686.668199862025;3691.5754688210127;5146.0479811233545;5277.86525896934;5287.814926477555;5294.629375943647;5305.257263983122;5095.592352611856;5111.284420181103;5115.590752739698;5119.411267704261;5120.692758434506;5080.187170052774;5098.592112631055;5110.182370820651;5145.562627176732;5149.382074151126;4872.780724867319;4970.801167953241;4979.701217926936;5075.949240507548;5079;4870.391201099863;4931.753412329297;5008.749562521933;5118.462561430996;5136.743162841918;4997.3253610762085;5028.899422011613;5052.772625231947;5061.8734531637;5070.619703522324 08:49:46 INFO - PROCESS | 6164 | |5;yui.html;645.7384759172535;684.8219462939634;707.193799069061;727.3235890621721;729.7774178875444;12787;13874.236916969563;13968.860311396884;13985.16089034656;13998.090124141923;12295.385230738471;12402.193857399263;12412.565560205372;12414.379281035957;12686.873131268685;759.3886921028584;780.9531428114303;784.7881072110526;785.1285073568363;787.1695361393728;783.3185128937804;785.2343964634492;786.1902240692096;786.2255678157011;786.3905473258242;820.6225136437246;822.5887056471764;822.7613991942329;822.9794255143639;823.2385043834429;805.2993895311058;806.3267171911461;809.9838003239902;813.2274339377556;813.3086876155251;593.8812237552506;593.9495142912857;594.5897330841706;594.9524038076944;595.0568349166576;13672.111312764639;13890.4443822247;13907.443702251898;13980.02139850211;14178.291085445686;12270.570530031495;12365.443555039954;12858.742825143445;13186.208827470287;13230.206187628677;10000.699979000641;10116.595336186543;10276.94861525695;10336.328138670962;10716.142708583295;3077.6306843178736;3080.445519806434;3110.3623757129735;3123.437781199383;3154.0380184043856;40840.59159408398;43957;60565.394346056855;61348.38651613471;62815.05777413343;9776.266779991529;9954.083387758574;9983.251256155672;10053.447060411747;10282.177425806067;18211.72682409765;18253.087345632666;18264.63470730578;18419.815801842076;18434.354797582022;6263.749450022039;6279.560430769802;6292.779752708633;6301.558890877594;6434.131392261985;3399.5240666306736;3450.3099380124077;3585.731070169748;3612.9277414451562;3637.5271214741915;2753.9586906196423;2802.6776920654384;2806.466771313444;2831.476176907279;2851.5294976328673;473.7749568954719;476.19047619047757;477.2030708716452;481.35258077885186;488.50172823720317;464.904694537619;487.27152906404444;565.3046752494455;581.5725441800273;595.3867516458055;7433.880631236849;7436.814079648052;7816.8827467588035;8008.399370047153;8202.876956845652;550.529297450682;565.5532129617638;585.0785013603592;586.2788769813154;592.2301008688687;3607.8737244196327;3641.9089522761615;3664.13892735207;3750.1937083527173;3833.5783063862955;64533;64871.67564162149;64962.35037649563;65426.03721888351;65995.67002165054;46372.536274637496;52022.739886300325;56921;57169.428305716414;57344.71327643419;53011.10855588749;53239.733801330745;53880.73059634755;54413.183802242995;54950.45049549454;7048.894266586108;7270.527415717961;7457.701691932262;7553.660085296285;7637.694492220471;35771.28457430785;36792.63207367999;38065;38246.42630360602;38425.42361864518;43628.56371436245;44758.32862507;48923.266151007054;49995.75002124966;52083.73958130185;11734.823977640172;11959.402029898645;12033.578824741093;12293.815592766294;12685.112042157329;12435;12762.872371276168;13057.542985995444;13242.53651122206;14413;11721.296722196696;12296.877031229573;12368.134230603771;12702;12978.253861985097;11439.370834603844;11822.113341499595;11896.702582435162;12025.75948481008;12450.25298482094;11636.94181529087;11855.17013809025;12391.442385092872;12392.690182745142;12734.554290599785;9914.603415863574;9920.851187232342;10004.549795259376;10543.26197166191;10607.734806629896;9619.51902404891;10407.94796026015;10521.789564208826;10538.736531586772;10542.631007914686 08:49:46 INFO - PROCESS | 6164 | __end_tp_report 08:49:46 INFO - PROCESS | 6164 | __start_cc_report 08:49:46 INFO - PROCESS | 6164 | _x_x_mozilla_cycle_collect,1315 08:49:46 INFO - PROCESS | 6164 | __end_cc_report 08:49:46 INFO - PROCESS | 6164 | __startTimestamp1481734186466__endTimestamp 08:49:46 INFO - PROCESS | 6164 | 08:49:46 INFO - PROCESS | 6164 | ------- Summary: start ------- 08:49:46 INFO - PROCESS | 6164 | Number of tests: 6 08:49:46 INFO - PROCESS | 6164 | 08:49:46 INFO - PROCESS | 6164 | [#0] dojo.html Cycles:165 Average:4659.03 Median:4757.71 stddev:485.31 (10.2%) stddev-sans-first:458.72 08:49:46 INFO - PROCESS | 6164 | Values: 2584.9 2621.5 2642.0 2650.2 2659.0 4634.0 4676.3 4700.5 4718.6 4725.9 4658.0 4689.9 4704.9 4723.4 4790.7 4270.2 4323.9 4332.2 4337.8 4342.0 4329.6 4369.1 4403.7 4463.8 4488.3 4411.3 4418.2 4429.2 4450.0 4471.0 4225.3 4254.2 4256.7 4312.1 4370.6 4240.6 4251.8 4264.6 4281.5 4339.4 4653.8 4659.7 4666.6 4678.6 4714.1 4914.0 4985.5 5010.3 5017.2 5059.4 4991.5 5028.9 5038.0 5051.5 5055.0 4728.0 4755.0 4756.6 4816.1 4821.4 5200.2 5203.6 5204.8 5208.2 5256.4 5002.2 5003.5 5003.6 5004.0 5054.7 4902.2 4967.8 4968.0 4969.0 5023.3 4942.6 4943.4 4944.2 4970.8 5008.5 4925.7 4935.7 4935.8 4941.5 4972.5 4203.5 4285.7 4289.7 4305.1 4338.2 3760.0 3767.2 3786.8 3788.3 3834.2 4323.9 4326.2 4330.4 4337.2 4373.1 5073.3 5079.4 5080.0 5108.0 5125.4 4214.6 4234.1 4239.2 4306.6 4330.9 4608.3 4608.9 4650.9 4665.0 4665.2 4717.5 4731.0 4731.4 4732.2 4774.0 4911.3 5080.2 5081.4 5083.7 5132.0 4611.4 4683.5 4702.1 4734.6 4743.5 4968.7 4983.3 5019.2 5019.4 5021.8 5018.6 5032.7 5052.8 5055.7 5056.2 4757.7 4788.9 4863.6 4932.6 4965.9 4833.3 4902.5 4932.1 4950.3 4992.3 4865.0 4885.4 4888.6 4904.3 4934.4 4996.6 4999.2 4999.3 5006.6 5056.2 4726.3 4761.7 4768.3 4797.7 4803.9 08:49:46 INFO - PROCESS | 6164 | 08:49:46 INFO - PROCESS | 6164 | [#1] ext.html Cycles:180 Average:37828.35 Median:3354.76 stddev:61258.07 (1826.0%) stddev-sans-first:61365.83 08:49:46 INFO - PROCESS | 6164 | Values: 511.6 548.2 553.3 560.3 572.0 28131.9 36917.4 38766.0 38865.2 42445.6 40032.4 40642.6 40675.5 40693.8 40695.2 7345.4 7470.3 7646.5 7647.7 7652.4 7367.7 9651.8 9892.0 9896.5 10176.5 9581.9 9644.2 9649.1 9655.6 9659.0 9735.6 9772.9 9826.2 9829.8 9848.9 9689.1 9761.1 9762.9 9766.8 9768.8 37800.0 38080.6 38080.8 38094.6 38146.0 3059.6 3087.6 3276.3 3287.4 3395.8 28622.7 28988.7 29084.0 29205.6 30315.7 3160.9 3322.9 3386.6 3423.8 3491.2 201597.0 247492.0 248343.0 248922.0 249414.0 46785.8 47400.8 47438.8 47528.8 47564.3 49760.8 49777.8 49796.8 49842.8 49871.5 11930.2 12260.4 12261.1 12284.8 12315.9 8856.6 8861.0 10259.3 10279.3 10417.8 15755.3 15769.1 15927.9 15958.8 16023.7 6436.8 6472.5 6492.1 6507.3 6519.5 745.7 842.7 895.9 945.3 945.4 26718.7 27894.3 28178.6 28639.9 28689.1 909.4 969.6 971.6 997.8 999.4 14015.9 15037.6 15055.6 15371.2 15372.6 104780.5 105038.0 105177.0 105192.0 105230.5 50142.7 50585.2 50820.0 50836.2 50937.0 1066.7 1078.8 1082.3 1190.2 1199.4 26075.6 28286.4 28998.3 31109.8 31321.4 47117.0 47768.8 47926.8 48014.0 48068.3 304131.0 306022.0 306438.0 307236.0 307261.0 22647.5 23704.2 23737.0 24960.6 25006.9 34384.3 34847.0 34867.1 34913.3 35901.0 29387.9 29570.3 29648.1 29992.5 30919.7 29136.6 29337.0 29493.1 30019.8 30202.4 29365.4 30139.7 30175.5 30608.5 30614.7 25596.2 27655.3 27660.4 27777.4 28066.4 21604.0 22105.2 22247.6 22339.6 22398.3 08:49:46 INFO - PROCESS | 6164 | 08:49:46 INFO - PROCESS | 6164 | [#2] jquery.html Cycles:180 Average:22019.52 Median:4036.57 stddev:56283.29 (1394.3%) stddev-sans-first:56417.63 08:49:46 INFO - PROCESS | 6164 | Values: 333.7 350.2 359.3 364.4 377.9 12341.1 12506.9 13222.7 13311.5 16078.6 15900.4 16078.6 16081.7 16224.9 16241.4 4864.6 5007.3 5103.4 5266.2 5307.7 5228.9 5261.1 5264.9 5267.3 5269.0 3420.4 3551.6 3598.0 4958.2 5242.9 5302.4 5305.3 5305.9 5311.6 5311.8 5000.9 5148.3 5167.6 5180.1 5185.5 11495.7 11723.5 11724.6 15797.3 18738.4 1811.1 1882.5 1910.6 1939.2 2082.9 8146.6 8311.4 8776.8 8920.8 9026.8 1633.4 1640.8 1672.5 1700.1 1735.9 64107.4 65775.0 65805.0 66921.3 67328.0 9570.7 9633.9 9855.0 9884.3 9914.4 13469.5 13482.0 13496.8 13507.5 13538.9 6811.9 7202.4 7237.4 7318.7 7448.7 6867.8 6904.2 7092.5 7095.1 7105.5 3963.9 4016.4 4056.8 4091.8 4120.6 1718.4 1739.4 1774.0 1796.2 1839.5 735.7 762.4 807.2 812.8 843.5 14772.1 14807.2 15082.4 15385.4 15722.8 731.6 766.9 778.3 794.0 806.2 7968.2 8264.6 8301.1 8368.1 8700.3 336947.0 337395.0 338363.0 342155.0 347774.0 66091.0 66612.7 66876.0 67892.2 72061.6 870.6 878.9 911.4 912.4 913.4 9464.4 14086.7 15068.3 15089.4 16598.5 34015.8 34041.0 35090.8 35176.0 35437.8 43709.3 44482.8 44589.0 50066.0 51300.5 9602.7 10317.5 10385.6 10809.2 10841.6 10308.8 10632.1 10939.5 11369.6 11750.4 9417.4 9489.0 9888.6 10317.9 10529.8 9960.8 10029.7 10074.2 10123.7 10161.5 10241.7 10358.3 10359.5 10395.9 11005.4 10197.9 10300.5 10398.0 10701.3 10854.2 9709.0 9797.4 9943.2 10018.9 10435.5 08:49:46 INFO - PROCESS | 6164 | 08:49:46 INFO - PROCESS | 6164 | [#3] mootools.html Cycles:180 Average:4675.09 Median:5840.15 stddev:2495.58 (42.7%) stddev-sans-first:2489.60 08:49:46 INFO - PROCESS | 6164 | Values: 1287.9 1327.8 1403.8 1623.8 1661.4 6105.7 6334.3 6717.5 7113.6 7120.4 6642.6 6912.8 6951.7 7037.8 7049.4 2088.8 2118.6 2133.9 2134.7 2139.6 1828.3 1891.4 2069.3 2096.6 2150.8 2003.7 2098.9 2102.3 2109.9 2114.3 2052.9 2055.9 2078.9 2081.8 2086.8 2116.7 2118.4 2125.4 2146.5 2149.5 6716.4 6784.7 6788.7 7042.1 7164.6 4244.3 4406.2 4409.0 4411.8 4413.8 2659.1 2718.0 2784.3 2786.3 2791.7 869.2 869.3 872.3 874.3 884.5 9272.3 9275.0 9289.1 9292.7 9297.7 3800.2 3894.9 3913.6 4069.0 4075.6 8087.6 8098.8 8099.6 8103.7 8108.0 4376.5 4377.8 4381.6 4386.2 4388.8 3959.5 4003.8 4004.6 4005.6 4008.6 3355.8 3361.8 3437.4 3454.1 3467.2 995.1 1033.0 1114.2 1139.4 1142.1 557.6 771.0 801.9 805.8 827.8 4801.3 4857.0 4863.7 4867.9 4895.2 815.2 827.2 850.0 853.9 887.5 3329.9 3336.5 3355.3 3376.7 3420.1 8246.7 8599.8 8620.4 8637.5 8646.3 8492.8 8507.5 8511.4 8525.2 8531.0 6641.6 6652.3 6652.4 6741.8 6774.7 4676.1 4784.0 5041.2 5136.2 5205.4 7731.7 7738.5 7790.5 7804.3 7823.3 7527.4 7804.6 7829.0 7935.9 8012.0 6184.8 6325.4 6331.6 6339.1 6358.1 6465.1 6518.3 6519.4 6519.8 6532.2 6037.0 6147.5 6279.5 6303.6 6373.4 6142.4 6157.8 6205.3 6242.3 6255.2 5801.5 5878.8 5878.9 5879.9 5924.1 4148.4 4175.4 4213.7 4258.8 4334.8 4142.0 4167.9 4227.9 4252.9 4323.7 08:49:46 INFO - PROCESS | 6164 | 08:49:46 INFO - PROCESS | 6164 | [#4] prototype.html Cycles:180 Average:4204.07 Median:4688.23 stddev:1177.59 (25.1%) stddev-sans-first:1144.55 08:49:46 INFO - PROCESS | 6164 | Values: 336.7 338.2 347.9 350.9 351.6 4841.6 4847.5 4870.8 4892.4 4916.8 4573.7 4607.3 4712.3 4770.9 4772.6 3844.4 3858.7 3859.9 3870.2 3873.9 3855.4 3856.4 3862.2 3862.3 3864.5 3566.7 3605.8 3832.3 3862.1 3863.9 3778.5 3800.7 3803.5 3811.4 3812.5 3447.4 3453.0 3460.2 3465.8 3480.5 4680.8 4689.6 4712.8 4720.4 4720.4 4208.7 4424.4 4472.8 4482.0 4483.8 5055.6 5075.8 5095.7 5109.3 5110.1 3852.2 3854.5 3857.5 3859.3 3874.6 5162.2 5282.3 5295.6 5301.9 5383.8 3925.5 3931.3 3938.6 3944.5 3945.2 3979.7 3988.0 4000.0 4006.7 4011.8 4290.5 4431.4 4468.7 4487.1 4504.3 5048.7 5053.7 5071.8 5077.9 5113.3 1340.4 1359.9 1363.9 1365.0 1367.9 903.7 923.2 946.2 982.1 983.5 4207.9 4237.5 4251.6 4254.6 4258.0 5029.3 5035.6 5061.1 5061.8 5072.5 4119.8 4252.9 4289.7 4294.5 4295.8 2656.6 2677.0 2682.8 2682.9 2692.8 4623.7 4676.8 4686.9 4691.4 4696.9 4867.3 5057.5 5133.3 5142.9 5175.6 4636.7 4638.7 4642.0 4651.3 4669.5 4950.7 4991.0 5002.5 5010.2 5022.7 4843.5 4868.1 4902.3 4913.6 5110.4 4822.5 4830.4 4843.7 4844.6 4872.3 3645.9 3676.9 3680.5 3686.7 3691.6 5146.0 5277.9 5287.8 5294.6 5305.3 5095.6 5111.3 5115.6 5119.4 5120.7 5080.2 5098.6 5110.2 5145.6 5149.4 4872.8 4970.8 4979.7 5075.9 5079.0 4870.4 4931.8 5008.7 5118.5 5136.7 4997.3 5028.9 5052.8 5061.9 5070.6 08:49:46 INFO - PROCESS | 6164 | 08:49:46 INFO - PROCESS | 6164 | [#5] yui.html Cycles:180 Average:14635.36 Median:43792.78 stddev:17920.94 (40.9%) stddev-sans-first:17940.42 08:49:46 INFO - PROCESS | 6164 | Values: 645.7 684.8 707.2 727.3 729.8 12787.0 13874.2 13968.9 13985.2 13998.1 12295.4 12402.2 12412.6 12414.4 12686.9 759.4 781.0 784.8 785.1 787.2 783.3 785.2 786.2 786.2 786.4 820.6 822.6 822.8 823.0 823.2 805.3 806.3 810.0 813.2 813.3 593.9 593.9 594.6 595.0 595.1 13672.1 13890.4 13907.4 13980.0 14178.3 12270.6 12365.4 12858.7 13186.2 13230.2 10000.7 10116.6 10276.9 10336.3 10716.1 3077.6 3080.4 3110.4 3123.4 3154.0 40840.6 43957.0 60565.4 61348.4 62815.1 9776.3 9954.1 9983.3 10053.4 10282.2 18211.7 18253.1 18264.6 18419.8 18434.4 6263.7 6279.6 6292.8 6301.6 6434.1 3399.5 3450.3 3585.7 3612.9 3637.5 2754.0 2802.7 2806.5 2831.5 2851.5 473.8 476.2 477.2 481.4 488.5 464.9 487.3 565.3 581.6 595.4 7433.9 7436.8 7816.9 8008.4 8202.9 550.5 565.6 585.1 586.3 592.2 3607.9 3641.9 3664.1 3750.2 3833.6 64533.0 64871.7 64962.4 65426.0 65995.7 46372.5 52022.7 56921.0 57169.4 57344.7 53011.1 53239.7 53880.7 54413.2 54950.5 7048.9 7270.5 7457.7 7553.7 7637.7 35771.3 36792.6 38065.0 38246.4 38425.4 43628.6 44758.3 48923.3 49995.8 52083.7 11734.8 11959.4 12033.6 12293.8 12685.1 12435.0 12762.9 13057.5 13242.5 14413.0 11721.3 12296.9 12368.1 12702.0 12978.3 11439.4 11822.1 11896.7 12025.8 12450.3 11636.9 11855.2 12391.4 12392.7 12734.6 9914.6 9920.9 10004.5 10543.3 10607.7 9619.5 10407.9 10521.8 10538.7 10542.6 08:49:46 INFO - PROCESS | 6164 | -------- Summary: end -------- 08:49:46 INFO - PROCESS | 6164 | 08:49:47 INFO - TEST-INFO | 6164: exit 0 08:49:47 INFO - TEST-OK | dromaeo_css | took 1122856ms 08:49:47 INFO - TEST-START | kraken 08:49:47 INFO - operating with platform_type : linux_ 08:49:47 INFO - Initialising browser for kraken test... 08:49:47 INFO - TEST-INFO | started process 6469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbUTSAP/profile http://localhost:58605/getInfo.html) 08:49:51 INFO - PROCESS | 6469 | __metrics Screen width/height:1600/1200 08:49:51 INFO - PROCESS | 6469 | colorDepth:24 08:49:51 INFO - PROCESS | 6469 | Browser inner width/height: 1024/697 08:49:51 INFO - PROCESS | 6469 | __metrics 08:49:52 INFO - PROCESS | 6469 | 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" 08:49:52 INFO - PROCESS | 6469 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:49:53 INFO - PROCESS | 6469 | console.error: PushService: 08:49:53 INFO - PROCESS | 6469 | stateChangeProcessEnqueue: Error transitioning state 08:49:53 INFO - PROCESS | 6469 | UnknownError 08:49:53 INFO - TEST-INFO | 6469: exit 0 08:49:53 INFO - Browser initialized. 08:49:53 INFO - Running cycle 1/1 for kraken test... 08:49:53 INFO - TEST-INFO | started process 6550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbUTSAP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:06 INFO - PROCESS | 6550 | RSS: Main: 173867008 08:50:06 INFO - PROCESS | 6550 | 08:50:09 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58605/tests/kraken/driver.html?testName=audio-beat-detection) 08:50:10 INFO - PROCESS | 6550 | RSS: Main: 235094016 08:50:10 INFO - PROCESS | 6550 | 08:50:12 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58605/tests/kraken/driver.html?testName=audio-dft) 08:50:13 INFO - PROCESS | 6550 | RSS: Main: 218370048 08:50:13 INFO - PROCESS | 6550 | 08:50:16 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58605/tests/kraken/driver.html?testName=audio-fft) 08:50:17 INFO - PROCESS | 6550 | RSS: Main: 300609536 08:50:17 INFO - PROCESS | 6550 | 08:50:19 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58605/tests/kraken/driver.html?testName=audio-oscillator) 08:50:19 INFO - PROCESS | 6550 | RSS: Main: 211075072 08:50:19 INFO - PROCESS | 6550 | 08:50:22 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58605/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:50:22 INFO - PROCESS | 6550 | RSS: Main: 214822912 08:50:22 INFO - PROCESS | 6550 | 08:50:26 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58605/tests/kraken/driver.html?testName=imaging-darkroom) 08:50:26 INFO - PROCESS | 6550 | RSS: Main: 253865984 08:50:26 INFO - PROCESS | 6550 | 08:50:30 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58605/tests/kraken/driver.html?testName=imaging-desaturate) 08:50:30 INFO - PROCESS | 6550 | RSS: Main: 254464000 08:50:30 INFO - PROCESS | 6550 | 08:50:33 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58605/tests/kraken/driver.html?testName=json-parse-financial) 08:50:34 INFO - PROCESS | 6550 | RSS: Main: 252616704 08:50:34 INFO - PROCESS | 6550 | 08:50:35 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58605/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:50:36 INFO - PROCESS | 6550 | RSS: Main: 214712320 08:50:36 INFO - PROCESS | 6550 | 08:50:38 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58605/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:50:39 INFO - PROCESS | 6550 | RSS: Main: 221663232 08:50:39 INFO - PROCESS | 6550 | 08:50:41 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58605/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:50:41 INFO - PROCESS | 6550 | RSS: Main: 230322176 08:50:41 INFO - PROCESS | 6550 | 08:50:44 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:50:45 INFO - PROCESS | 6550 | RSS: Main: 239833088 08:50:45 INFO - PROCESS | 6550 | 08:50:48 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:50:49 INFO - PROCESS | 6550 | RSS: Main: 235868160 08:50:49 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | Cycle 1(1): loaded http://localhost:58605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58605/tests/kraken/driver.html?testName=ai-astar) 08:50:51 INFO - PROCESS | 6550 | RSS: Main: 289124352 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | __start_tp_report 08:50:51 INFO - PROCESS | 6550 | _x_x_mozilla_page_load 08:50:51 INFO - PROCESS | 6550 | _x_x_mozilla_page_load_details 08:50:51 INFO - PROCESS | 6550 | |i|pagename|runs| 08:50:51 INFO - PROCESS | 6550 | |0;ai-astar;113;117;116;115;117;117;115;114;116;116 08:50:51 INFO - PROCESS | 6550 | |1;audio-beat-detection;161;127;137;171;134;134;128;128;158;127 08:50:51 INFO - PROCESS | 6550 | |2;audio-dft;161;162;163;162;163;162;162;161;161;160 08:50:51 INFO - PROCESS | 6550 | |3;audio-fft;75;77;77;103;77;76;86;78;89;76 08:50:51 INFO - PROCESS | 6550 | |4;audio-oscillator;85;87;112;92;85;85;99;85;84;110 08:50:51 INFO - PROCESS | 6550 | |5;imaging-gaussian-blur;127;127;127;126;126;127;127;127;126;128 08:50:51 INFO - PROCESS | 6550 | |6;imaging-darkroom;147;146;147;148;147;148;146;148;147;147 08:50:51 INFO - PROCESS | 6550 | |7;imaging-desaturate;95;96;96;96;97;96;96;96;96;95 08:50:51 INFO - PROCESS | 6550 | |8;json-parse-financial;63;62;63;62;63;65;63;64;65;65 08:50:51 INFO - PROCESS | 6550 | |9;json-stringify-tinderbox;66;67;66;67;75;66;67;66;67;67 08:50:51 INFO - PROCESS | 6550 | |10;stanford-crypto-aes;85;86;89;95;85;85;85;86;85;86 08:50:51 INFO - PROCESS | 6550 | |11;stanford-crypto-ccm;148;153;151;151;139;140;149;152;186;143 08:50:51 INFO - PROCESS | 6550 | |12;stanford-crypto-pbkdf2;177;179;175;181;182;179;180;181;182;181 08:50:51 INFO - PROCESS | 6550 | |13;stanford-crypto-sha256-iterative;73;68;76;68;69;67;69;68;67;68 08:50:51 INFO - PROCESS | 6550 | __end_tp_report 08:50:51 INFO - PROCESS | 6550 | __start_cc_report 08:50:51 INFO - PROCESS | 6550 | _x_x_mozilla_cycle_collect,1937 08:50:51 INFO - PROCESS | 6550 | __end_cc_report 08:50:51 INFO - PROCESS | 6550 | __startTimestamp1481734251395__endTimestamp 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | ------- Summary: start ------- 08:50:51 INFO - PROCESS | 6550 | Number of tests: 14 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.00 stddev:1.35 (1.2%) stddev-sans-first:1.05 08:50:51 INFO - PROCESS | 6550 | Values: 113.0 117.0 116.0 115.0 117.0 117.0 115.0 114.0 116.0 116.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:135.50 stddev:16.43 (12.1%) stddev-sans-first:15.67 08:50:51 INFO - PROCESS | 6550 | Values: 161.0 127.0 137.0 171.0 134.0 134.0 128.0 128.0 158.0 127.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 08:50:51 INFO - PROCESS | 6550 | Values: 161.0 162.0 163.0 162.0 163.0 162.0 162.0 161.0 161.0 160.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#3] audio-fft Cycles:10 Average:81.40 Median:77.00 stddev:8.91 (11.6%) stddev-sans-first:9.14 08:50:51 INFO - PROCESS | 6550 | Values: 75.0 77.0 77.0 103.0 77.0 76.0 86.0 78.0 89.0 76.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:85.00 stddev:10.83 (12.7%) stddev-sans-first:11.16 08:50:51 INFO - PROCESS | 6550 | Values: 85.0 87.0 112.0 92.0 85.0 85.0 99.0 85.0 84.0 110.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#5] imaging-gaussian-blur Cycles:10 Average:126.80 Median:127.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 08:50:51 INFO - PROCESS | 6550 | Values: 127.0 127.0 127.0 126.0 126.0 127.0 127.0 127.0 126.0 128.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:50:51 INFO - PROCESS | 6550 | Values: 147.0 146.0 147.0 148.0 147.0 148.0 146.0 148.0 147.0 147.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 08:50:51 INFO - PROCESS | 6550 | Values: 95.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.50 stddev:1.18 (1.9%) stddev-sans-first:1.24 08:50:51 INFO - PROCESS | 6550 | Values: 63.0 62.0 63.0 62.0 63.0 65.0 63.0 64.0 65.0 65.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:2.72 (4.1%) stddev-sans-first:2.83 08:50:51 INFO - PROCESS | 6550 | Values: 66.0 67.0 66.0 67.0 75.0 66.0 67.0 66.0 67.0 67.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:3.16 (3.7%) stddev-sans-first:3.30 08:50:51 INFO - PROCESS | 6550 | Values: 85.0 86.0 89.0 95.0 85.0 85.0 85.0 86.0 85.0 86.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:151.00 stddev:13.21 (8.8%) stddev-sans-first:13.97 08:50:51 INFO - PROCESS | 6550 | Values: 148.0 153.0 151.0 151.0 139.0 140.0 149.0 152.0 186.0 143.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:181.00 stddev:2.26 (1.3%) stddev-sans-first:2.18 08:50:51 INFO - PROCESS | 6550 | Values: 177.0 179.0 175.0 181.0 182.0 179.0 180.0 181.0 182.0 181.0 08:50:51 INFO - PROCESS | 6550 | 08:50:51 INFO - PROCESS | 6550 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:68.50 stddev:2.91 (4.2%) stddev-sans-first:2.76 08:50:51 INFO - PROCESS | 6550 | Values: 73.0 68.0 76.0 68.0 69.0 67.0 69.0 68.0 67.0 68.0 08:50:51 INFO - PROCESS | 6550 | -------- Summary: end -------- 08:50:51 INFO - PROCESS | 6550 | 08:50:52 INFO - TEST-INFO | 6550: exit 0 08:50:52 INFO - TEST-OK | kraken | took 65303ms 08:50:52 INFO - SUITE-END | took 1188s 08:50:53 INFO - Completed test suite (00:19:48) 08:50:53 INFO - javascript benchmark 08:50:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2584.8836802343894, 2621.501914636218, 2642.0224516928733, 2650.1651979626417, 2659.002873922278, 4633.976830115845, 4676.275177347512, 4700.482946875841, 4718.551737584929, 4725.929111063337, 4657.976710116444, 4689.929651055237, 4704.905901881961, 4723.409573803275, 4790.664653474259, 4270.231358355495, 4323.913521729563, 4332.24185767491, 4337.848175313865, 4342.0, 4329.631981281579, 4369.104333611618, 4403.669724770639, 4463.754493502856, 4488.281874900017, 4411.316245981862, 4418.204723149832, 4429.247028005247, 4449.977750111245, 4470.97764511177, 4225.302825033866, 4254.234237837188, 4256.723312984646, 4312.094460163369, 4370.584794444522, 4240.554741752102, 4251.766152861592, 4264.573542645741, 4281.4648168978565, 4339.370791235253, 4653.813847446098, 4659.650526210514, 4666.626669866402, 4678.555537223959, 4714.080754252922, 4913.975430122862, 4985.451600323961, 5010.273510341017, 5017.172166592508, 5059.443461219263, 4991.450940396553, 5028.899422011576, 5037.974810125963, 5051.494850514956, 5054.974725126388, 4728.030753695519, 4755.0489902019735, 4756.571908528249, 4816.060868130751, 4821.421429428421, 5200.24596433515, 5203.60972927032, 5204.76578553966, 5208.192730126836, 5256.369235691665, 5002.224655178453, 5003.524665156804, 5003.5997120230295, 5004.0, 5054.671446355975, 4902.191138462185, 4967.751612419364, 4968.0312339093525, 4969.031038947371, 5023.34696489454, 4942.555170034642, 4943.357363542788, 4944.233643785219, 4970.751462426936, 5008.549230569266, 4925.679830810986, 4935.654504184745, 4935.7532123393685, 4941.45643979162, 4972.5027497249985, 4203.47456567929, 4285.7000009999, 4289.699721019499, 4305.117450922553, 4338.197433474817, 3760.0, 3767.2088861339425, 3786.7917264550715, 3788.337041017866, 3834.213986132836, 4323.935140972888, 4326.15639950213, 4330.39374487572, 4337.175936572041, 4373.1472362888935, 5073.315102461121, 5079.415867175248, 5080.0, 5108.0, 5125.436202017775, 4214.620684138442, 4234.110836724322, 4239.236937351307, 4306.633936115402, 4330.891727706832, 4608.331791890224, 4608.9308660370125, 4650.906981860411, 4664.95335046652, 4665.160271151225, 4717.481077081518, 4731.030138821602, 4731.3612662291525, 4732.171869922681, 4774.045190961752, 4911.312416261655, 5080.161773307363, 5081.364829396325, 5083.72039537829, 5131.974340128276, 4611.446626404853, 4683.461401938821, 4702.083093796677, 4734.6449016324605, 4743.45450273223, 4968.726720030289, 4983.277424773315, 5019.247112932943, 5019.3976722793495, 5021.799128034984, 5018.573421259088, 5032.6980381177245, 5052.823151189691, 5055.7219352935945, 5056.216286475602, 4757.714537127784, 4788.928166077581, 4863.610911127172, 4932.630052745986, 4965.851024469272, 4833.347498087714, 4902.4607293197005, 4932.062908047459, 4950.282209079735, 4992.326035985241, 4864.95135048645, 4885.40829189362, 4888.560029597211, 4904.264360345834, 4934.358533390637, 4996.550310471929, 4999.225120106389, 4999.275105109666, 5006.624503162205, 5056.191009438472, 4726.291056341576, 4761.6904901181315, 4768.3085952537385, 4797.712137271775, 4803.903921921612], "value": 4628.1225540564665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.649520078746, 548.1531034551617, 553.3083645443196, 560.277242357359, 572.0475408444934, 28131.859340703293, 36917.44623830642, 38766.0, 38865.22269554607, 42445.57554424455, 40032.39951400732, 40642.59357406425, 40675.52569217384, 40693.7965310173, 40695.18609627813, 7345.449091318146, 7470.32767050964, 7646.464747467679, 7647.694092236332, 7652.387808975269, 7367.742129025485, 9651.80696386072, 9891.950540247324, 9896.455694936776, 10176.542055607515, 9581.904180958205, 9644.18024467921, 9649.083337082966, 9655.565499552502, 9659.0, 9735.610575576968, 9772.853407198898, 9826.213902887752, 9829.803403931954, 9848.90151098487, 9689.079537443931, 9761.07269809367, 9762.853557196648, 9766.755831104208, 9768.804623907554, 37800.0, 38080.61919380799, 38080.80959595212, 38094.61905380939, 38146.0, 3059.571659967584, 3087.5986121804244, 3276.2955964467756, 3287.3589650018257, 3395.847186876572, 28622.713772862215, 28988.71011289902, 29084.0, 29205.561916571267, 30315.696843031506, 3160.9051728448185, 3322.9169270768184, 3386.5936087669393, 3423.8288085595623, 3491.2493813830147, 201597.0, 247492.0, 248343.0, 248921.9999999982, 249414.0, 46785.766071169426, 47400.76299618549, 47438.76280618575, 47528.762356187995, 47564.28653570199, 49760.751196243786, 49777.751111244215, 49796.75101624541, 49842.77594196917, 49871.50128498668, 11930.164888457899, 12260.448279827251, 12261.080418968613, 12284.754304913851, 12315.876841231653, 8856.557172141367, 8860.955695221483, 10259.333143345659, 10279.280450368551, 10417.791644167075, 15755.291011904492, 15769.132697701507, 15927.920360398355, 15958.808238352376, 16023.679526409407, 6436.80689579304, 6472.546921715435, 6492.123563318986, 6507.284198738135, 6519.511036672268, 745.7240820896303, 842.7050532313641, 895.8521843895684, 945.2815859946353, 945.4469135555639, 26718.732812671624, 27894.3026424341, 28178.577321340195, 28639.856800715865, 28689.13932582026, 909.417972497602, 969.5782334684435, 971.6404930175739, 997.8453339732353, 999.3803841618243, 14015.85984140166, 15037.624059398384, 15055.623609409853, 15371.231438428034, 15372.615684607974, 104780.47609761903, 105038.0, 105177.0, 105192.0, 105230.47384763027, 50142.74928625333, 50585.24122138171, 50820.0, 50836.23745643818, 50937.0, 1066.7066556696816, 1078.7518870659949, 1082.280283611421, 1190.1966172833304, 1199.4242763473408, 26075.60886586665, 28286.43427131487, 28998.27504312409, 31109.8444507776, 31321.37357252888, 47117.0, 47768.761156194, 47926.81097835213, 48014.0, 48068.27897581609, 304131.0, 306022.0, 306438.0, 307236.0, 307261.0, 22647.547049059256, 23704.170354037527, 23737.0, 24960.625590615793, 25006.874965625055, 34384.312313753086, 34847.0, 34867.12832179216, 34913.30173396467, 35901.0, 29387.85306073456, 29570.260743481584, 29648.110556683336, 29992.5003749816, 30919.69080309258, 29136.56295155532, 29337.0, 29493.115206543836, 30019.849900750356, 30202.395952081275, 29365.41269174562, 30139.698603014567, 30175.547366789076, 30608.540871887384, 30614.693853061184, 25596.23211303664, 27655.30861728473, 27660.446791064467, 27777.44445111046, 28066.438671226868, 21604.0, 22105.226317078825, 22247.55504889861, 22339.553208936057, 22398.32805015852], "value": 16411.222767489788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.681334325719, 350.22949511075626, 359.2599245554158, 364.40238009664154, 377.8658576205447, 12341.074419418546, 12506.937465312662, 13222.669433264173, 13311.467541298349, 16078.59803504913, 15900.363985440568, 16078.59803504913, 16081.678366432665, 16224.918875405607, 16241.431549895757, 4864.610831133509, 5007.349044624194, 5103.41310749263, 5266.157414813631, 5307.73461326934, 5228.921566176491, 5261.079311120558, 5264.894702105956, 5267.315249017623, 5269.0, 3420.4185288501017, 3551.6093229744706, 3597.964020359789, 4958.231474121517, 5242.9213561796605, 5302.44324345942, 5305.283786688806, 5305.920411193835, 5311.62818602698, 5311.760970756325, 5000.899982000376, 5148.330717006766, 5167.560757335631, 5180.119379705459, 5185.455527169631, 11495.65513034602, 11723.472443740053, 11724.648260552198, 15797.289121989537, 18738.437846864617, 1811.0944527736133, 1882.4823173627226, 1910.6274276515946, 1939.2243102758869, 2082.8958552072336, 8146.5519396433765, 8311.418200725951, 8776.780580485474, 8920.776980575472, 9026.819463610756, 1633.3793158599656, 1640.75388691696, 1672.540051485839, 1700.1414285785722, 1735.878488505805, 64107.358926410605, 65775.0, 65805.01292480569, 66921.33078669249, 67328.0, 9570.665026724031, 9633.9036609633, 9854.99462943076, 9884.258680598983, 9914.40513569188, 13469.528566500125, 13482.0, 13496.797548036788, 13507.459701612022, 13538.93230533841, 6811.897821532681, 7202.387797037206, 7237.384822290059, 7318.670659820321, 7448.664810083559, 6867.828304292432, 6904.206016308089, 7092.5389849659605, 7095.148582170069, 7105.538140020882, 3963.900902477461, 4016.377461493473, 4056.7565946043333, 4091.8363265469643, 4120.608542188487, 1718.3556166437586, 1739.4259894235124, 1773.9976913044088, 1796.2365994452566, 1839.5125291797685, 735.6983636708924, 762.4357975098499, 807.2250639386137, 812.8049268175595, 843.5149788871423, 14772.113673179643, 14807.185604791624, 15082.396704131712, 15385.384584616713, 15722.842771572137, 731.5829976913109, 766.9271419215165, 778.3267473635265, 793.9920600794034, 806.1897792718281, 7968.243016913384, 8264.586770661443, 8301.086880443147, 8368.079511253758, 8700.30397568193, 336947.0, 337395.0, 338363.0, 342154.96598027344, 347774.0, 66091.0, 66612.666936665, 66876.0, 67892.1740173784, 72061.63969180225, 870.564717641192, 878.8769572259761, 911.4212475078373, 912.4160537256162, 913.4199783137756, 9464.432134071978, 14086.718265634834, 15068.321925513159, 15089.396424142911, 16598.502044938672, 34015.829920850236, 34041.0, 35090.824545877105, 35176.0, 35437.82281088578, 43709.34435983526, 44482.777586111864, 44589.0, 50066.0, 51300.48699512957, 9602.711918642452, 10317.535710892878, 10385.63650272237, 10809.189310801565, 10841.566337346418, 10308.793824123626, 10632.149428045583, 10939.507722152362, 11369.602063927723, 11750.412479376168, 9417.434953902513, 9488.95255523718, 9888.604455821687, 10317.896821031994, 10529.842052369373, 9960.800783984134, 10029.749256268651, 10074.244431667801, 10123.696289111338, 10161.491925403849, 10241.692749217535, 10358.326708763907, 10359.482025898826, 10395.896041039492, 11005.449727513753, 10197.932878407102, 10300.484975751033, 10398.012188842047, 10701.304415212986, 10854.18593605467, 9708.951455242679, 9797.363171393836, 9943.154831839085, 10018.899811001796, 10435.530401131815], "value": 7805.894149751867, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.9420426080826, 1327.8472975607806, 1403.8245219347582, 1623.7970253718286, 1661.3686799016373, 6105.6947152642415, 6334.3032266450655, 6717.496187785917, 7113.644317784109, 7120.394766444845, 6642.601443913369, 6912.758053468129, 6951.652417379136, 7037.824054398642, 7049.436045116391, 2088.8120069193806, 2118.6186486432434, 2133.9039743211515, 2134.6797980303, 2139.6362618354838, 1828.2778302570478, 1891.432570228926, 2069.317125348631, 2096.6121267565472, 2150.774168712286, 2003.6794112941932, 2098.8950552472393, 2102.3272552783114, 2109.9050542725536, 2114.3022802475225, 2052.8768273903465, 2055.876647401153, 2078.8544801863877, 2081.791820817929, 2086.7600225974056, 2116.703661487393, 2118.396257066744, 2125.4048866317457, 2146.549224662823, 2149.4733790221494, 6716.429103526158, 6784.660766961632, 6788.72845086196, 7042.084529011247, 7164.605946672931, 4244.257254980366, 4406.184855801687, 4408.977955110204, 4411.823527058914, 4413.845515406977, 2659.1091984185323, 2717.9592306115424, 2784.3456787654886, 2786.289496178482, 2791.6510436195476, 869.1699427047218, 869.3479890082439, 872.3021582733787, 874.3092956564307, 884.5090974509145, 9272.258219342504, 9275.0, 9289.071092890725, 9292.674756383494, 9297.72106836796, 3800.220954704279, 3894.8636797711943, 3913.6086391360636, 4069.04377471294, 4075.572064933199, 8087.595620218965, 8098.75703728889, 8099.595020248964, 8103.716369927024, 8107.986501687289, 4376.518582955872, 4377.846775362847, 4381.583749543788, 4386.232409328355, 4388.824447022083, 3959.5050618672667, 4003.8398464061693, 4004.5795191505053, 4005.5794141615293, 4008.6191811777835, 3355.815430151365, 3361.83190840457, 3437.415639341318, 3454.101933497309, 3467.1678797088516, 995.0994350113159, 1033.0495943731635, 1114.1755101225035, 1139.3733446604335, 1142.0749193153572, 557.5511713071016, 770.9768706938801, 801.9318357939641, 805.7743831727125, 827.8385714785559, 4801.303810947463, 4856.95143048572, 4863.659543831898, 4867.878303042381, 4895.216765317603, 815.1603848036532, 827.210014436212, 849.9783270473526, 853.9274161696326, 887.454215657366, 3329.916752081169, 3336.5328853960464, 3355.278615097766, 3376.74674399421, 3420.127867393848, 8246.711365102192, 8599.78500537479, 8620.396572240008, 8637.524936128573, 8646.26506746921, 8492.830143397097, 8507.489550626982, 8511.446755960842, 8525.232729054414, 8531.0, 6641.634710090992, 6652.268250492442, 6652.368025037614, 6741.831454213586, 6774.661266936633, 4676.134915040729, 4783.95216047835, 5041.168207245763, 5136.203888397305, 5205.401378841481, 7731.690732370642, 7738.535687858746, 7790.493617914817, 7804.336631386395, 7823.2567906048835, 7527.397808175442, 7804.570748608654, 7829.0, 7935.920640793749, 8011.959940200261, 6184.81445556634, 6325.399087086719, 6331.620102793847, 6339.144215531029, 6358.141650877073, 6465.127207826883, 6518.315576864361, 6519.41325280708, 6519.771807986698, 6532.248791388861, 6037.0, 6147.508199343953, 6279.466245369194, 6303.590266632654, 6373.3945275198785, 6142.447179753844, 6157.815265542041, 6205.348438414082, 6242.250929888442, 6255.155554000334, 5801.535877129904, 5878.764849406147, 5878.941210587839, 5879.882402352015, 5924.140999554954, 4148.419221309079, 4175.436316097288, 4213.683973701924, 4258.8296468140925, 4334.848280310174, 4142.0, 4167.8958026049595, 4227.915441691211, 4252.851150209728, 4323.740575565476], "value": 3825.398547465476, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.68015385383893, 338.2440246050078, 347.9269353435778, 350.9245512214873, 351.6237625740459, 4841.612670986321, 4847.539483749047, 4870.805167793288, 4892.437369702481, 4916.754162291889, 4573.725576465406, 4607.28587069004, 4712.269598212282, 4770.856874293768, 4772.57046865782, 3844.4041173618134, 3858.672012878909, 3859.864904728335, 3870.2196989384915, 3873.9418908716393, 3855.4216867469822, 3856.3636999894984, 3862.1503269280715, 3862.324093283678, 3864.458975743384, 3566.7324950628677, 3605.7836529808164, 3832.2910261601555, 3862.1310205203886, 3863.884083477486, 3778.527684039495, 3800.714946379019, 3803.5245594300713, 3811.3711237645757, 3812.5424949006297, 3447.4484082546674, 3452.9654703452893, 3460.2214501737158, 3465.8267086645565, 3480.547528821237, 4680.812767489297, 4689.601383882374, 4712.835050773241, 4720.3863497745415, 4720.409948756405, 4208.737378786383, 4424.40270563473, 4472.843450479218, 4481.977590112061, 4483.753393563353, 5055.5702765265, 5075.771590278409, 5095.694258344474, 5109.259157422191, 5110.131277682765, 3852.1525264442057, 3854.5181852268465, 3857.5341370279116, 3859.3439115350457, 3874.593167717377, 5162.199859021857, 5282.313299271109, 5295.629305948585, 5301.867453313621, 5383.811566595189, 3925.450436938831, 3931.253061918226, 3938.6455219030427, 3944.467496887941, 3945.2109578083923, 3979.7413168143976, 3988.0, 4000.0, 4006.6794656427414, 4011.7592944423427, 4290.485141782943, 4431.423914891108, 4468.687191896601, 4487.147441986078, 4504.301833215857, 5048.722320272347, 5053.747312634354, 5071.822486212965, 5077.8730531737, 5113.258577506241, 1340.4370164530922, 1359.9256587296122, 1363.9181649101085, 1364.9830875997445, 1367.924764137962, 903.6927444668713, 923.1691477670016, 946.2004606107828, 982.1308142293979, 983.5050722901293, 4207.873763787091, 4237.470316210473, 4251.553586873334, 4254.553271906405, 4258.0, 5029.270755740397, 5035.571976381975, 5061.139606266944, 5061.772220250024, 5072.51811077947, 4119.7940102994735, 4252.851150209728, 4289.742615443083, 4294.527601963781, 4295.8496452624, 2656.641353417264, 2676.9598456023177, 2682.785377169822, 2682.919512414631, 2692.8384296942245, 4623.653226008063, 4676.784036150625, 4686.859394218179, 4691.437027556715, 4696.8590942271785, 4867.294242334841, 5057.482755173433, 5133.329669286478, 5142.948570514322, 5175.560077393388, 4636.698614590041, 4638.652101092432, 4642.001969576557, 4651.279051746985, 4669.509701481364, 4950.727709975986, 4991.001799640014, 5002.474740152377, 5010.198368261061, 5022.719206602293, 4843.539863712942, 4868.148074087091, 4902.313676085422, 4913.63147763912, 5110.437851836221, 4822.541858523435, 4830.420349558076, 4843.660943734046, 4844.563989240985, 4872.293517440023, 3645.888004158651, 3676.852925882935, 3680.4847321374496, 3686.668199862025, 3691.5754688210127, 5146.0479811233545, 5277.86525896934, 5287.814926477555, 5294.629375943647, 5305.257263983122, 5095.592352611856, 5111.284420181103, 5115.590752739698, 5119.411267704261, 5120.692758434506, 5080.187170052774, 5098.592112631055, 5110.182370820651, 5145.562627176732, 5149.382074151126, 4872.780724867319, 4970.801167953241, 4979.701217926936, 5075.949240507548, 5079.0, 4870.391201099863, 4931.753412329297, 5008.749562521933, 5118.462561430996, 5136.743162841918, 4997.3253610762085, 5028.899422011613, 5052.772625231947, 5061.8734531637, 5070.619703522324], "value": 3848.0605978257563, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.7384759172535, 684.8219462939634, 707.193799069061, 727.3235890621721, 729.7774178875444, 12787.0, 13874.236916969563, 13968.860311396884, 13985.16089034656, 13998.090124141923, 12295.385230738471, 12402.193857399263, 12412.565560205372, 12414.379281035957, 12686.873131268685, 759.3886921028584, 780.9531428114303, 784.7881072110526, 785.1285073568363, 787.1695361393728, 783.3185128937804, 785.2343964634492, 786.1902240692096, 786.2255678157011, 786.3905473258242, 820.6225136437246, 822.5887056471764, 822.7613991942329, 822.9794255143639, 823.2385043834429, 805.2993895311058, 806.3267171911461, 809.9838003239902, 813.2274339377556, 813.3086876155251, 593.8812237552506, 593.9495142912857, 594.5897330841706, 594.9524038076944, 595.0568349166576, 13672.111312764639, 13890.4443822247, 13907.443702251898, 13980.02139850211, 14178.291085445686, 12270.570530031495, 12365.443555039954, 12858.742825143445, 13186.208827470287, 13230.206187628677, 10000.699979000641, 10116.595336186543, 10276.94861525695, 10336.328138670962, 10716.142708583295, 3077.6306843178736, 3080.445519806434, 3110.3623757129735, 3123.437781199383, 3154.0380184043856, 40840.59159408398, 43957.0, 60565.394346056855, 61348.38651613471, 62815.05777413343, 9776.266779991529, 9954.083387758574, 9983.251256155672, 10053.447060411747, 10282.177425806067, 18211.72682409765, 18253.087345632666, 18264.63470730578, 18419.815801842076, 18434.354797582022, 6263.749450022039, 6279.560430769802, 6292.779752708633, 6301.558890877594, 6434.131392261985, 3399.5240666306736, 3450.3099380124077, 3585.731070169748, 3612.9277414451562, 3637.5271214741915, 2753.9586906196423, 2802.6776920654384, 2806.466771313444, 2831.476176907279, 2851.5294976328673, 473.7749568954719, 476.19047619047757, 477.2030708716452, 481.35258077885186, 488.50172823720317, 464.904694537619, 487.27152906404444, 565.3046752494455, 581.5725441800273, 595.3867516458055, 7433.880631236849, 7436.814079648052, 7816.8827467588035, 8008.399370047153, 8202.876956845652, 550.529297450682, 565.5532129617638, 585.0785013603592, 586.2788769813154, 592.2301008688687, 3607.8737244196327, 3641.9089522761615, 3664.13892735207, 3750.1937083527173, 3833.5783063862955, 64533.0, 64871.67564162149, 64962.35037649563, 65426.03721888351, 65995.67002165054, 46372.536274637496, 52022.739886300325, 56921.0, 57169.428305716414, 57344.71327643419, 53011.10855588749, 53239.733801330745, 53880.73059634755, 54413.183802242995, 54950.45049549454, 7048.894266586108, 7270.527415717961, 7457.701691932262, 7553.660085296285, 7637.694492220471, 35771.28457430785, 36792.63207367999, 38065.0, 38246.42630360602, 38425.42361864518, 43628.56371436245, 44758.32862507, 48923.266151007054, 49995.75002124966, 52083.73958130185, 11734.823977640172, 11959.402029898645, 12033.578824741093, 12293.815592766294, 12685.112042157329, 12435.0, 12762.872371276168, 13057.542985995444, 13242.53651122206, 14413.0, 11721.296722196696, 12296.877031229573, 12368.134230603771, 12702.0, 12978.253861985097, 11439.370834603844, 11822.113341499595, 11896.702582435162, 12025.75948481008, 12450.25298482094, 11636.94181529087, 11855.17013809025, 12391.442385092872, 12392.690182745142, 12734.554290599785, 9914.603415863574, 9920.851187232342, 10004.549795259376, 10543.26197166191, 10607.734806629896, 9619.51902404891, 10407.94796026015, 10521.789564208826, 10538.736531586772, 10542.631007914686], "value": 6201.320420634365, "unit": "score"}], "name": "dromaeo_css", "value": 6150.399322953707, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 116.0, 115.0, 117.0, 117.0, 115.0, 114.0, 116.0, 116.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 137.0, 171.0, 134.0, 134.0, 128.0, 128.0, 158.0, 127.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 162.0, 163.0, 162.0, 162.0, 161.0, 161.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 103.0, 77.0, 76.0, 86.0, 78.0, 89.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 112.0, 92.0, 85.0, 85.0, 99.0, 85.0, 84.0, 110.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 126.0, 126.0, 127.0, 127.0, 127.0, 126.0, 128.0], "value": 126.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 147.0, 148.0, 146.0, 148.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 63.0, 65.0, 63.0, 64.0, 65.0, 65.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 75.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 89.0, 95.0, 85.0, 85.0, 85.0, 86.0, 85.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 153.0, 151.0, 151.0, 139.0, 140.0, 149.0, 152.0, 186.0, 143.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 179.0, 175.0, 181.0, 182.0, 179.0, 180.0, 181.0, 182.0, 181.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 76.0, 68.0, 69.0, 67.0, 69.0, 68.0, 67.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1579.2000000000003, "alertThreshold": 2.0}]} 08:50:53 INFO - Return code: 0 08:50:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:50:53 INFO - # TBPL SUCCESS # 08:50:53 INFO - Running post-action listener: _resource_record_post_action 08:50:53 INFO - [mozharness: 2016-12-14 16:50:53.171172Z] Finished run-tests step (success) 08:50:53 INFO - Running post-run listener: _resource_record_post_run 08:50:53 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392220672; Read time: 12; Write time: 338008 08:50:53 INFO - TinderboxPrint: CPU usage
13.2% 08:50:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:50:53 INFO - TinderboxPrint: I/O write bytes / time
392,220,672 / 338,008 08:50:53 INFO - TinderboxPrint: CPU idle
8,348.7 (86.8%) 08:50:53 INFO - TinderboxPrint: CPU user
1,216.5 (12.7%) 08:50:53 INFO - TinderboxPrint: Swap in / out
0 / 0 08:50:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99811328; Read time: 0; Write time: 102276 08:50:53 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 292409344; Read time: 0; Write time: 235732 08:50:53 INFO - Running post-run listener: _upload_blobber_files 08:50:53 INFO - Blob upload gear active. 08:50:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:50:53 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 08:50:53 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'] 08:50:53 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 08:50:54 INFO - (blobuploader) - INFO - Open directory for files ... 08:50:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:50:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:50:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:55 INFO - (blobuploader) - INFO - Done attempting. 08:50:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:50:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:50:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:58 INFO - (blobuploader) - INFO - Done attempting. 08:50:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:50:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:50:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:59 INFO - (blobuploader) - INFO - Done attempting. 08:50:59 INFO - (blobuploader) - INFO - Iteration through files over. 08:50:59 INFO - Return code: 0 08:50:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:50:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:50:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e973bc3a90ee6bdc1913a320fbfeb0b663600a75a776f1910969b74b9e5b8a7965c92e76ad18eb230599b322666cdde7b0dcaecc056fc7cd1ea5ee21ec5c3d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1566bbb9d17978a803a01def7c99913f9b7c4f7245a07a7b93d3ae958d5ab009a463de354644e196a8194bc038afd0805d0716e65823b10e40abdaade568350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fd5b35a37b83fdded7bb9251ef8830110998ac2f7a0e3f53a5209701512b2b08fe3a85dabebe41a46959f16bc7b72daf3c21f230cbb10006473c962a878b38"} 08:50:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:50:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:50:59 INFO - Contents: 08:50:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e973bc3a90ee6bdc1913a320fbfeb0b663600a75a776f1910969b74b9e5b8a7965c92e76ad18eb230599b322666cdde7b0dcaecc056fc7cd1ea5ee21ec5c3d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1566bbb9d17978a803a01def7c99913f9b7c4f7245a07a7b93d3ae958d5ab009a463de354644e196a8194bc038afd0805d0716e65823b10e40abdaade568350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fd5b35a37b83fdded7bb9251ef8830110998ac2f7a0e3f53a5209701512b2b08fe3a85dabebe41a46959f16bc7b72daf3c21f230cbb10006473c962a878b38"} 08:50:59 INFO - Running post-run listener: copy_logs_to_upload_dir 08:50:59 INFO - Copying logs to upload dir... 08:50:59 INFO - mkdir: /builds/slave/test/build/upload/logs 08:50:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.737700 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-12-14 08:50:58.837858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 08:50:58.841139) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743 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/2e973bc3a90ee6bdc1913a320fbfeb0b663600a75a776f1910969b74b9e5b8a7965c92e76ad18eb230599b322666cdde7b0dcaecc056fc7cd1ea5ee21ec5c3d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1566bbb9d17978a803a01def7c99913f9b7c4f7245a07a7b93d3ae958d5ab009a463de354644e196a8194bc038afd0805d0716e65823b10e40abdaade568350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fd5b35a37b83fdded7bb9251ef8830110998ac2f7a0e3f53a5209701512b2b08fe3a85dabebe41a46959f16bc7b72daf3c21f230cbb10006473c962a878b38"} build_url:https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011948 build_url: 'https://queue.taskcluster.net/v1/task/Fk1ikrfiRX-auvqc9nL3CA/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/2e973bc3a90ee6bdc1913a320fbfeb0b663600a75a776f1910969b74b9e5b8a7965c92e76ad18eb230599b322666cdde7b0dcaecc056fc7cd1ea5ee21ec5c3d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1566bbb9d17978a803a01def7c99913f9b7c4f7245a07a7b93d3ae958d5ab009a463de354644e196a8194bc038afd0805d0716e65823b10e40abdaade568350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51fd5b35a37b83fdded7bb9251ef8830110998ac2f7a0e3f53a5209701512b2b08fe3a85dabebe41a46959f16bc7b72daf3c21f230cbb10006473c962a878b38"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 08:50:58.867757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:50:58.868103) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1481733009.100857-312701743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:50:58.952615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 08:50:58.952955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 08:50:58.953282) ========= ========= Total master_lag: 0.18 =========