builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1483122451.79 results: success (0) buildid: 20161230093919 builduid: faa3eef4d0af4db7b1b2bc72612d210f revision: a00632dc133aa17fbb42197911b8ce7833bf9386 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:31.794723) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:31.795295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:31.795579) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:31.820282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:31.820562) ========= 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=d2a8c569965ab8367867b893000001a1-1483120912.576580-606264268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-30 10:27:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-12-30 10:27:32 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125150 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:31.959074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:31.959375) ========= 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=d2a8c569965ab8367867b893000001a1-1483120912.576580-606264268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017187 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:32.007937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:32.008253) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev a00632dc133aa17fbb42197911b8ce7833bf9386 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev a00632dc133aa17fbb42197911b8ce7833bf9386 --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=d2a8c569965ab8367867b893000001a1-1483120912.576580-606264268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-30 10:27:32,330 truncating revision to first 12 chars 2016-12-30 10:27:32,331 Setting DEBUG logging. 2016-12-30 10:27:32,331 attempt 1/10 2016-12-30 10:27:32,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/a00632dc133a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-30 10:27:32,882 unpacking tar archive at: graphics-a00632dc133a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.897357 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:32.922133) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:32.922455) ========= script_repo_revision: a00632dc133aa17fbb42197911b8ce7833bf9386 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:32.922928) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:32.923252) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 10:27:32.934115) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-12-30 10:27:32.934740) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=d2a8c569965ab8367867b893000001a1-1483120912.576580-606264268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:27:33 INFO - MultiFileLogger online at 20161230 10:27:33 in /builds/slave/test 10:27:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 10:27:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:27:33 INFO - {'append_to_log': False, 10:27:33 INFO - 'base_work_dir': '/builds/slave/test', 10:27:33 INFO - 'blob_upload_branch': 'Graphics', 10:27:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:27:33 INFO - 'branch': 'Graphics', 10:27:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:27:33 INFO - 'config_files': ('talos/linux_config.py',), 10:27:33 INFO - 'default_actions': ('clobber', 10:27:33 INFO - 'read-buildbot-config', 10:27:33 INFO - 'download-and-extract', 10:27:33 INFO - 'populate-webroot', 10:27:33 INFO - 'create-virtualenv', 10:27:33 INFO - 'install', 10:27:33 INFO - 'run-tests'), 10:27:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:27:33 INFO - 'download_minidump_stackwalk': True, 10:27:33 INFO - 'download_symbols': 'ondemand', 10:27:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:27:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:27:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:27:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:27:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:27:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:27:33 INFO - 'installer_path': 'installer.exe', 10:27:33 INFO - 'log_level': 'info', 10:27:33 INFO - 'log_name': 'talos', 10:27:33 INFO - 'log_to_console': True, 10:27:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:27:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:27:33 INFO - 'opt_config_files': (), 10:27:33 INFO - 'pip_index': False, 10:27:33 INFO - 'sps_profile': False, 10:27:33 INFO - 'sps_profile_interval': 0, 10:27:33 INFO - 'suite': 'dromaeojs', 10:27:33 INFO - 'system_bits': '32', 10:27:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:27:33 INFO - 'title': 'talos-linux64-ix-043', 10:27:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:27:33 INFO - 'use_talos_json': True, 10:27:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:27:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:27:33 INFO - 'work_dir': 'build'} 10:27:33 INFO - [mozharness: 2016-12-30 18:27:33.346647Z] Running clobber step. 10:27:33 INFO - Running pre-action listener: _resource_record_pre_action 10:27:33 INFO - Running main action method: clobber 10:27:33 INFO - rmtree: /builds/slave/test/build 10:27:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:27:33 INFO - Running post-action listener: _resource_record_post_action 10:27:33 INFO - [mozharness: 2016-12-30 18:27:33.808108Z] Finished clobber step (success) 10:27:33 INFO - [mozharness: 2016-12-30 18:27:33.808210Z] Running read-buildbot-config step. 10:27:33 INFO - Running pre-action listener: _resource_record_pre_action 10:27:33 INFO - Running main action method: read_buildbot_config 10:27:33 INFO - Using buildbot properties: 10:27:33 INFO - { 10:27:33 INFO - "project": "", 10:27:33 INFO - "product": "firefox", 10:27:33 INFO - "script_repo_revision": "default", 10:27:33 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 10:27:33 INFO - "repository": "", 10:27:33 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 10:27:33 INFO - "buildid": "20161230093919", 10:27:33 INFO - "pgo_build": "False", 10:27:33 INFO - "basedir": "/builds/slave/test", 10:27:33 INFO - "buildnumber": 44, 10:27:33 INFO - "slavename": "talos-linux64-ix-043", 10:27:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:27:33 INFO - "platform": "ubuntu64_hw", 10:27:33 INFO - "scheduler": "tests-graphics-linux64-talos", 10:27:33 INFO - "branch": "graphics", 10:27:33 INFO - "repo_path": "projects/graphics", 10:27:33 INFO - "revision": "a00632dc133aa17fbb42197911b8ce7833bf9386", 10:27:33 INFO - "stage_platform": "linux64", 10:27:33 INFO - "builduid": "faa3eef4d0af4db7b1b2bc72612d210f", 10:27:33 INFO - "slavebuilddir": "test" 10:27:33 INFO - } 10:27:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 10:27:33 INFO - Running post-action listener: _resource_record_post_action 10:27:33 INFO - [mozharness: 2016-12-30 18:27:33.810705Z] Finished read-buildbot-config step (success) 10:27:33 INFO - [mozharness: 2016-12-30 18:27:33.810796Z] Running download-and-extract step. 10:27:33 INFO - Running pre-action listener: _resource_record_pre_action 10:27:33 INFO - Running main action method: download_and_extract 10:27:33 INFO - mkdir: /builds/slave/test/build/tests 10:27: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')]} 10:27:33 INFO - trying https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:27:33 INFO - Downloading https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/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 10:27:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/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 10:27:34 INFO - Downloaded 1361 bytes. 10:27:34 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:27:34 INFO - Using the following test package requirements: 10:27:34 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:27:34 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:27:34 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:27:34 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:27:34 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:27:34 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:27:34 INFO - u'jsshell-linux-x86_64.zip'], 10:27:34 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:27:34 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:27:34 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:27:34 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:27:34 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:27:34 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:27:34 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:27:34 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:27:34 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:27:34 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:27:34 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:27:34 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:27:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:27:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:27:34 INFO - Fetch https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:27:36 INFO - Expected file size: 20246119 10:27:36 INFO - Obtained file size: 20246119 10:27:40 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 10:27:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:27:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:27:40 INFO - Fetch https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:27:40 INFO - Expected file size: 20246119 10:27:40 INFO - Obtained file size: 20246119 10:27:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 10:27:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:27:45 INFO - Fetch https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:27:46 INFO - Expected file size: 14409776 10:27:46 INFO - Obtained file size: 14409776 10:27: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')]} 10:27:47 INFO - trying https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:27:47 INFO - Downloading https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/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 10:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/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 10:27:50 INFO - Downloaded 55929340 bytes. 10:27:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:27:50 INFO - mkdir: /builds/slave/test/properties 10:27:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:27:50 INFO - Writing to file /builds/slave/test/properties/build_url 10:27:50 INFO - Contents: 10:27:50 INFO - build_url:https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:27:51 INFO - Running post-action listener: _resource_record_post_action 10:27:51 INFO - Running post-action listener: set_extra_try_arguments 10:27:51 INFO - [mozharness: 2016-12-30 18:27:51.085989Z] Finished download-and-extract step (success) 10:27:51 INFO - [mozharness: 2016-12-30 18:27:51.086223Z] Running populate-webroot step. 10:27:51 INFO - Running pre-action listener: _resource_record_pre_action 10:27:51 INFO - Running main action method: populate_webroot 10:27:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:27:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:27:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:27:51 INFO - '--tppagecycles', 10:27:51 INFO - '7'], 10:27:51 INFO - 'tests': ['tsvgm']}}, 10:27:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:27:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:27:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:27:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:27:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:27:51 INFO - 'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:27:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:27:51 INFO - 'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['damp', 'tps']}, 10:27:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:27:51 INFO - 'tests': ['damp', 'tps']}, 10:27:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['dromaeo_dom']}, 10:27:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:27:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['basic_compositor_video']}, 10:27:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:27:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['a11yr', 10:27:51 INFO - 'ts_paint', 10:27:51 INFO - 'tpaint', 10:27:51 INFO - 'sessionrestore', 10:27:51 INFO - 'sessionrestore_no_auto_restore', 10:27:51 INFO - 'tabpaint']}, 10:27:51 INFO - 'other-e10s': {'tests': ['a11yr', 10:27:51 INFO - 'ts_paint', 10:27:51 INFO - 'tpaint', 10:27:51 INFO - 'sessionrestore', 10:27:51 INFO - 'sessionrestore_no_auto_restore', 10:27:51 INFO - 'tabpaint']}, 10:27:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:27:51 INFO - 'ts_paint', 10:27:51 INFO - 'tpaint', 10:27:51 INFO - 'sessionrestore', 10:27:51 INFO - 'sessionrestore_no_auto_restore', 10:27:51 INFO - 'tabpaint']}, 10:27:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:27:51 INFO - 'ts_paint', 10:27:51 INFO - 'tpaint', 10:27:51 INFO - 'sessionrestore', 10:27:51 INFO - 'sessionrestore_no_auto_restore', 10:27:51 INFO - 'tabpaint']}, 10:27:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['a11yr', 10:27:51 INFO - 'ts_paint', 10:27:51 INFO - 'tpaint', 10:27:51 INFO - 'sessionrestore', 10:27:51 INFO - 'sessionrestore_no_auto_restore', 10:27:51 INFO - 'tabpaint']}, 10:27:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['a11yr', 10:27:51 INFO - 'ts_paint', 10:27:51 INFO - 'tpaint', 10:27:51 INFO - 'sessionrestore', 10:27:51 INFO - 'sessionrestore_no_auto_restore', 10:27:51 INFO - 'tabpaint']}, 10:27:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['tsvgx', 10:27:51 INFO - 'tsvgr_opacity', 10:27:51 INFO - 'tart', 10:27:51 INFO - 'tscrollx', 10:27:51 INFO - 'cart', 10:27:51 INFO - 'tsvg_static']}, 10:27:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:27:51 INFO - 'tsvgr_opacity', 10:27:51 INFO - 'tart', 10:27:51 INFO - 'tscrollx', 10:27:51 INFO - 'cart', 10:27:51 INFO - 'tsvg_static']}, 10:27:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:27:51 INFO - 'talos_options': ['--disable-e10s'], 10:27:51 INFO - 'tests': ['tp5o']}, 10:27:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:27:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:27:51 INFO - 'talos_options': ['--disable-e10s', 10:27:51 INFO - '--xperf_path', 10:27:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:51 INFO - 'tests': ['tp5n']}, 10:27:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:27:51 INFO - 'talos_options': ['--xperf_path', 10:27:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:51 INFO - 'tests': ['tp5n']}}, 10:27:51 INFO - 'talos.zip': {'path': '', 10:27:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:27:51 INFO - Running post-action listener: _resource_record_post_action 10:27:51 INFO - [mozharness: 2016-12-30 18:27:51.101808Z] Finished populate-webroot step (success) 10:27:51 INFO - [mozharness: 2016-12-30 18:27:51.101898Z] Running create-virtualenv step. 10:27:51 INFO - Running pre-action listener: _resource_record_pre_action 10:27:51 INFO - Running main action method: create_virtualenv 10:27:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:27:51 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 10:27:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:27:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:27:51 INFO - Using real prefix '/usr' 10:27:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:27:51 INFO - Installing distribute.............................................................................................................................................................................................done. 10:27:53 INFO - Installing pip.................done. 10:27:53 INFO - Return code: 0 10:27:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:27:53 INFO - Reading from file tmpfile_stdout 10:27:53 INFO - Output received: 10:27:53 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) 10:27:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:27:53 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')]} 10:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:53 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')]} 10:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:53 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 0x14991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, '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': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', '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 10:27:53 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 10:27:53 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 10:27:53 INFO - Using env: {'DISPLAY': ':0', 10:27:53 INFO - 'HOME': '/home/cltbld', 10:27:53 INFO - 'LANG': 'en_US.UTF-8', 10:27:53 INFO - 'LANGUAGE': 'en_US:en', 10:27:53 INFO - 'LOGNAME': 'cltbld', 10:27:53 INFO - 'MAIL': '/var/mail/cltbld', 10:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:53 INFO - 'MOZ_NO_REMOTE': '1', 10:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:53 INFO - 'NO_EM_RESTART': '1', 10:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:53 INFO - 'PWD': '/builds/slave/test', 10:27:53 INFO - 'SHELL': '/bin/bash', 10:27:53 INFO - 'SHLVL': '1', 10:27:53 INFO - 'TERM': 'linux', 10:27:53 INFO - 'TMOUT': '86400', 10:27:53 INFO - 'USER': 'cltbld', 10:27:53 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:53 INFO - '_': '/tools/buildbot/bin/python'} 10:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:54 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 10:27:54 INFO - Cleaning up... 10:27:54 INFO - Return code: 0 10:27:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:27:54 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')]} 10:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:54 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')]} 10:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:54 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 0x14991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, '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': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', '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 10:27:54 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 10:27:54 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 10:27:54 INFO - Using env: {'DISPLAY': ':0', 10:27:54 INFO - 'HOME': '/home/cltbld', 10:27:54 INFO - 'LANG': 'en_US.UTF-8', 10:27:54 INFO - 'LANGUAGE': 'en_US:en', 10:27:54 INFO - 'LOGNAME': 'cltbld', 10:27:54 INFO - 'MAIL': '/var/mail/cltbld', 10:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:54 INFO - 'MOZ_NO_REMOTE': '1', 10:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:54 INFO - 'NO_EM_RESTART': '1', 10:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:54 INFO - 'PWD': '/builds/slave/test', 10:27:54 INFO - 'SHELL': '/bin/bash', 10:27:54 INFO - 'SHLVL': '1', 10:27:54 INFO - 'TERM': 'linux', 10:27:54 INFO - 'TMOUT': '86400', 10:27:54 INFO - 'USER': 'cltbld', 10:27:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:54 INFO - '_': '/tools/buildbot/bin/python'} 10:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:54 INFO - Downloading/unpacking psutil>=3.1.1 10:27:54 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 10:27:54 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 10:27:54 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 10:27:54 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 10:27:54 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 10:27:54 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 10:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:27:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:56 INFO - Installing collected packages: psutil 10:27:56 INFO - Running setup.py install for psutil 10:27:56 INFO - building 'psutil._psutil_linux' extension 10:27:56 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 10:27:56 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 10:27:56 INFO - building 'psutil._psutil_posix' extension 10:27:56 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 10:27:56 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 10:27:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:56 INFO - Successfully installed psutil 10:27:56 INFO - Cleaning up... 10:27:56 INFO - Return code: 0 10:27:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:56 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 0x14991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, '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': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', '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 10:27:56 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 10:27:56 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 10:27:57 INFO - Using env: {'DISPLAY': ':0', 10:27:57 INFO - 'HOME': '/home/cltbld', 10:27:57 INFO - 'LANG': 'en_US.UTF-8', 10:27:57 INFO - 'LANGUAGE': 'en_US:en', 10:27:57 INFO - 'LOGNAME': 'cltbld', 10:27:57 INFO - 'MAIL': '/var/mail/cltbld', 10:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:57 INFO - 'MOZ_NO_REMOTE': '1', 10:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:57 INFO - 'NO_EM_RESTART': '1', 10:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:57 INFO - 'PWD': '/builds/slave/test', 10:27:57 INFO - 'SHELL': '/bin/bash', 10:27:57 INFO - 'SHLVL': '1', 10:27:57 INFO - 'TERM': 'linux', 10:27:57 INFO - 'TMOUT': '86400', 10:27:57 INFO - 'USER': 'cltbld', 10:27:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:57 INFO - '_': '/tools/buildbot/bin/python'} 10:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:27:59 INFO - Installing collected packages: mozsystemmonitor 10:27:59 INFO - Running setup.py install for mozsystemmonitor 10:27:59 INFO - Successfully installed mozsystemmonitor 10:27:59 INFO - Cleaning up... 10:27:59 INFO - Return code: 0 10:27:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, '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': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', '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 10:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:27:59 INFO - Using env: {'DISPLAY': ':0', 10:27:59 INFO - 'HOME': '/home/cltbld', 10:27:59 INFO - 'LANG': 'en_US.UTF-8', 10:27:59 INFO - 'LANGUAGE': 'en_US:en', 10:27:59 INFO - 'LOGNAME': 'cltbld', 10:27:59 INFO - 'MAIL': '/var/mail/cltbld', 10:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:59 INFO - 'MOZ_NO_REMOTE': '1', 10:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:59 INFO - 'NO_EM_RESTART': '1', 10:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:59 INFO - 'PWD': '/builds/slave/test', 10:27:59 INFO - 'SHELL': '/bin/bash', 10:27:59 INFO - 'SHLVL': '1', 10:27:59 INFO - 'TERM': 'linux', 10:27:59 INFO - 'TMOUT': '86400', 10:27:59 INFO - 'USER': 'cltbld', 10:27:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:59 INFO - '_': '/tools/buildbot/bin/python'} 10:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:59 INFO - Downloading/unpacking jsonschema==2.5.1 10:27:59 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 10:27:59 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 10:27:59 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 10:27:59 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 10:27:59 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 10:27:59 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 10:28:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:28:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:28:01 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 10:28:01 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 10:28:01 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 10:28:01 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 10:28:01 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 10:28:01 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 10:28:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:28:01 INFO - warning: no files found matching '*.txt' 10:28:01 INFO - no previously-included directories found matching 'build' 10:28:01 INFO - no previously-included directories found matching 'dist' 10:28:01 INFO - no previously-included directories found matching '.git*' 10:28:01 INFO - Installing collected packages: jsonschema, functools32 10:28:01 INFO - Running setup.py install for functools32 10:28:02 INFO - warning: no files found matching '*.txt' 10:28:02 INFO - no previously-included directories found matching 'build' 10:28:02 INFO - no previously-included directories found matching 'dist' 10:28:02 INFO - no previously-included directories found matching '.git*' 10:28:02 INFO - Successfully installed jsonschema functools32 10:28:02 INFO - Cleaning up... 10:28:02 INFO - Return code: 0 10:28:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:28:02 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')]} 10:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:02 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')]} 10:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:02 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 0x14991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, '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': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', '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 10:28:02 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 10:28:02 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 10:28:02 INFO - Using env: {'DISPLAY': ':0', 10:28:02 INFO - 'HOME': '/home/cltbld', 10:28:02 INFO - 'LANG': 'en_US.UTF-8', 10:28:02 INFO - 'LANGUAGE': 'en_US:en', 10:28:02 INFO - 'LOGNAME': 'cltbld', 10:28:02 INFO - 'MAIL': '/var/mail/cltbld', 10:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:02 INFO - 'MOZ_NO_REMOTE': '1', 10:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:02 INFO - 'NO_EM_RESTART': '1', 10:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:02 INFO - 'PWD': '/builds/slave/test', 10:28:02 INFO - 'SHELL': '/bin/bash', 10:28:02 INFO - 'SHLVL': '1', 10:28:02 INFO - 'TERM': 'linux', 10:28:02 INFO - 'TMOUT': '86400', 10:28:02 INFO - 'USER': 'cltbld', 10:28:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:02 INFO - '_': '/tools/buildbot/bin/python'} 10:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:28:02 INFO - Cleaning up... 10:28:02 INFO - Return code: 0 10:28:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:28:02 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')]} 10:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:02 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')]} 10:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:02 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 0x14991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, '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': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', '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 10:28:02 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 10:28:02 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 10:28:02 INFO - Using env: {'DISPLAY': ':0', 10:28:02 INFO - 'HOME': '/home/cltbld', 10:28:02 INFO - 'LANG': 'en_US.UTF-8', 10:28:02 INFO - 'LANGUAGE': 'en_US:en', 10:28:02 INFO - 'LOGNAME': 'cltbld', 10:28:02 INFO - 'MAIL': '/var/mail/cltbld', 10:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:02 INFO - 'MOZ_NO_REMOTE': '1', 10:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:02 INFO - 'NO_EM_RESTART': '1', 10:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:02 INFO - 'PWD': '/builds/slave/test', 10:28:02 INFO - 'SHELL': '/bin/bash', 10:28:02 INFO - 'SHLVL': '1', 10:28:02 INFO - 'TERM': 'linux', 10:28:02 INFO - 'TMOUT': '86400', 10:28:02 INFO - 'USER': 'cltbld', 10:28:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:02 INFO - '_': '/tools/buildbot/bin/python'} 10:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:28:02 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 10:28:02 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 10:28:02 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 10:28:02 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 10:28:02 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 10:28:02 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 10:28:04 INFO - Downloading blobuploader-1.2.4.tar.gz 10:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:28:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:28:04 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 10:28:04 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 10:28:04 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 10:28:04 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 10:28:04 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 10:28:04 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 10:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:28:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:28:05 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 10:28:05 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 10:28:05 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 10:28:05 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 10:28:05 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 10:28:05 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 10:28:05 INFO - Downloading docopt-0.6.1.tar.gz 10:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:28:05 INFO - Installing collected packages: blobuploader, requests, docopt 10:28:05 INFO - Running setup.py install for blobuploader 10:28:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:28:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:28:05 INFO - Running setup.py install for requests 10:28:05 INFO - Running setup.py install for docopt 10:28:05 INFO - Successfully installed blobuploader requests docopt 10:28:05 INFO - Cleaning up... 10:28:05 INFO - Return code: 0 10:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:05 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')]} 10:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:05 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')]} 10:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:06 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 0x14991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, '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': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', '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 10:28:06 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 10:28:06 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 10:28:06 INFO - Using env: {'DISPLAY': ':0', 10:28:06 INFO - 'HOME': '/home/cltbld', 10:28:06 INFO - 'LANG': 'en_US.UTF-8', 10:28:06 INFO - 'LANGUAGE': 'en_US:en', 10:28:06 INFO - 'LOGNAME': 'cltbld', 10:28:06 INFO - 'MAIL': '/var/mail/cltbld', 10:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:06 INFO - 'MOZ_NO_REMOTE': '1', 10:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:06 INFO - 'NO_EM_RESTART': '1', 10:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:06 INFO - 'PWD': '/builds/slave/test', 10:28:06 INFO - 'SHELL': '/bin/bash', 10:28:06 INFO - 'SHLVL': '1', 10:28:06 INFO - 'TERM': 'linux', 10:28:06 INFO - 'TMOUT': '86400', 10:28:06 INFO - 'USER': 'cltbld', 10:28:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:06 INFO - '_': '/tools/buildbot/bin/python'} 10:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:06 INFO - Running setup.py (path:/tmp/pip-VqZvqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:06 INFO - Running setup.py (path:/tmp/pip-RHlZJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:06 INFO - Running setup.py (path:/tmp/pip-CehaXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:06 INFO - Running setup.py (path:/tmp/pip-UYwW4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:06 INFO - Running setup.py (path:/tmp/pip-YmhG4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:06 INFO - Running setup.py (path:/tmp/pip-HuPz9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:06 INFO - Running setup.py (path:/tmp/pip-tGUuuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:06 INFO - Running setup.py (path:/tmp/pip-_cifIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:06 INFO - Running setup.py (path:/tmp/pip-Kcj_VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:06 INFO - Running setup.py (path:/tmp/pip-i_3Onf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:06 INFO - Running setup.py (path:/tmp/pip-qPtoR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:07 INFO - Running setup.py (path:/tmp/pip-YOPN4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:07 INFO - Running setup.py (path:/tmp/pip-2B1Avk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:07 INFO - Running setup.py (path:/tmp/pip-6jspLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:07 INFO - Running setup.py (path:/tmp/pip-Pttjfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:07 INFO - Running setup.py (path:/tmp/pip-jB0vba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:07 INFO - Running setup.py (path:/tmp/pip-RLYRbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:28:07 INFO - Running setup.py install for manifestparser 10:28:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Running setup.py install for mozcrash 10:28:07 INFO - Running setup.py install for mozdebug 10:28:07 INFO - Running setup.py install for mozdevice 10:28:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Running setup.py install for mozfile 10:28:07 INFO - Running setup.py install for mozhttpd 10:28:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Running setup.py install for mozinfo 10:28:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Running setup.py install for mozInstall 10:28:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Running setup.py install for mozleak 10:28:08 INFO - Running setup.py install for mozlog 10:28:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Running setup.py install for moznetwork 10:28:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Running setup.py install for mozprocess 10:28:08 INFO - Running setup.py install for mozprofile 10:28:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Running setup.py install for mozrunner 10:28:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Running setup.py install for mozscreenshot 10:28:09 INFO - Running setup.py install for moztest 10:28:09 INFO - Running setup.py install for mozversion 10:28:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:28:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:28:09 INFO - Cleaning up... 10:28:09 INFO - Return code: 0 10:28:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:09 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 0x14991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, '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': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', '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 10:28:09 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 10:28:09 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 10:28:09 INFO - Using env: {'DISPLAY': ':0', 10:28:09 INFO - 'HOME': '/home/cltbld', 10:28:09 INFO - 'LANG': 'en_US.UTF-8', 10:28:09 INFO - 'LANGUAGE': 'en_US:en', 10:28:09 INFO - 'LOGNAME': 'cltbld', 10:28:09 INFO - 'MAIL': '/var/mail/cltbld', 10:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:09 INFO - 'MOZ_NO_REMOTE': '1', 10:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:09 INFO - 'NO_EM_RESTART': '1', 10:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:09 INFO - 'PWD': '/builds/slave/test', 10:28:09 INFO - 'SHELL': '/bin/bash', 10:28:09 INFO - 'SHLVL': '1', 10:28:09 INFO - 'TERM': 'linux', 10:28:09 INFO - 'TMOUT': '86400', 10:28:09 INFO - 'USER': 'cltbld', 10:28:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:09 INFO - '_': '/tools/buildbot/bin/python'} 10:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:09 INFO - Running setup.py (path:/tmp/pip-iJehNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:09 INFO - Running setup.py (path:/tmp/pip-mDYAJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:09 INFO - Running setup.py (path:/tmp/pip-2k5JJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:09 INFO - Running setup.py (path:/tmp/pip-x5V14H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:09 INFO - Running setup.py (path:/tmp/pip-MTfVwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:09 INFO - Running setup.py (path:/tmp/pip-zkvjNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:09 INFO - Running setup.py (path:/tmp/pip-3mI5cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:09 INFO - Running setup.py (path:/tmp/pip-nTt_sA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:10 INFO - Running setup.py (path:/tmp/pip-QyMfPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:10 INFO - Running setup.py (path:/tmp/pip-iBemtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:10 INFO - Running setup.py (path:/tmp/pip-HEleqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:10 INFO - Running setup.py (path:/tmp/pip-KHx65E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:10 INFO - Running setup.py (path:/tmp/pip-arKuNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:10 INFO - Running setup.py (path:/tmp/pip-7F2Swg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:10 INFO - Running setup.py (path:/tmp/pip-4hbFMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:10 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)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:10 INFO - Running setup.py (path:/tmp/pip-w51cN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:10 INFO - Running setup.py (path:/tmp/pip-3BWzTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:10 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)) 10:28:10 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)) 10:28:10 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)) 10:28:10 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)) 10:28:10 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)) 10:28:10 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)) 10:28:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:28:10 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 10:28:10 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 10:28:10 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 10:28:10 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 10:28:10 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 10:28:10 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 10:28:12 INFO - Downloading blessings-1.6.tar.gz 10:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:28:12 INFO - Installing collected packages: blessings 10:28:12 INFO - Running setup.py install for blessings 10:28:12 INFO - Successfully installed blessings 10:28:12 INFO - Cleaning up... 10:28:12 INFO - Return code: 0 10:28:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:13 INFO - Reading from file tmpfile_stdout 10:28:13 INFO - Current package versions: 10:28:13 INFO - argparse == 1.2.1 10:28:13 INFO - blessings == 1.6 10:28:13 INFO - blobuploader == 1.2.4 10:28:13 INFO - docopt == 0.6.1 10:28:13 INFO - functools32 == 3.2.3-2 10:28:13 INFO - jsonschema == 2.5.1 10:28:13 INFO - manifestparser == 1.1 10:28:13 INFO - mozInstall == 1.12 10:28:13 INFO - mozcrash == 1.0 10:28:13 INFO - mozdebug == 0.1 10:28:13 INFO - mozdevice == 0.49 10:28:13 INFO - mozfile == 1.2 10:28:13 INFO - mozhttpd == 0.7 10:28:13 INFO - mozinfo == 0.9 10:28:13 INFO - mozleak == 0.1 10:28:13 INFO - mozlog == 3.4 10:28:13 INFO - moznetwork == 0.27 10:28:13 INFO - mozprocess == 0.23 10:28:13 INFO - mozprofile == 0.28 10:28:13 INFO - mozrunner == 6.13 10:28:13 INFO - mozscreenshot == 0.1 10:28:13 INFO - mozsystemmonitor == 0.3 10:28:13 INFO - moztest == 0.8 10:28:13 INFO - mozversion == 1.4 10:28:13 INFO - psutil == 3.1.1 10:28:13 INFO - requests == 1.2.3 10:28:13 INFO - wsgiref == 0.1.2 10:28:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:13 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')]} 10:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:13 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')]} 10:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:13 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 0x14991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, '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': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', '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 10:28:13 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 10:28:13 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 10:28:13 INFO - Using env: {'DISPLAY': ':0', 10:28:13 INFO - 'HOME': '/home/cltbld', 10:28:13 INFO - 'LANG': 'en_US.UTF-8', 10:28:13 INFO - 'LANGUAGE': 'en_US:en', 10:28:13 INFO - 'LOGNAME': 'cltbld', 10:28:13 INFO - 'MAIL': '/var/mail/cltbld', 10:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:13 INFO - 'MOZ_NO_REMOTE': '1', 10:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:13 INFO - 'NO_EM_RESTART': '1', 10:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:13 INFO - 'PWD': '/builds/slave/test', 10:28:13 INFO - 'SHELL': '/bin/bash', 10:28:13 INFO - 'SHLVL': '1', 10:28:13 INFO - 'TERM': 'linux', 10:28:13 INFO - 'TMOUT': '86400', 10:28:13 INFO - 'USER': 'cltbld', 10:28:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:13 INFO - '_': '/tools/buildbot/bin/python'} 10:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 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)) 10:28:13 INFO - Cleaning up... 10:28:13 INFO - Return code: 0 10:28:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:28:13 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')]} 10:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:13 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')]} 10:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:13 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 0x14991f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, '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': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', '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 10:28:13 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 10:28:13 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 10:28:13 INFO - Using env: {'DISPLAY': ':0', 10:28:13 INFO - 'HOME': '/home/cltbld', 10:28:13 INFO - 'LANG': 'en_US.UTF-8', 10:28:13 INFO - 'LANGUAGE': 'en_US:en', 10:28:13 INFO - 'LOGNAME': 'cltbld', 10:28:13 INFO - 'MAIL': '/var/mail/cltbld', 10:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:13 INFO - 'MOZ_NO_REMOTE': '1', 10:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:13 INFO - 'NO_EM_RESTART': '1', 10:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:13 INFO - 'PWD': '/builds/slave/test', 10:28:13 INFO - 'SHELL': '/bin/bash', 10:28:13 INFO - 'SHLVL': '1', 10:28:13 INFO - 'TERM': 'linux', 10:28:13 INFO - 'TMOUT': '86400', 10:28:13 INFO - 'USER': 'cltbld', 10:28:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:13 INFO - '_': '/tools/buildbot/bin/python'} 10:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:28:13 INFO - Cleaning up... 10:28:13 INFO - Return code: 0 10:28:13 INFO - Running post-action listener: _resource_record_post_action 10:28:13 INFO - Running post-action listener: _start_resource_monitoring 10:28:13 INFO - Starting resource monitoring. 10:28:13 INFO - [mozharness: 2016-12-30 18:28:13.707061Z] Finished create-virtualenv step (success) 10:28:13 INFO - [mozharness: 2016-12-30 18:28:13.707568Z] Running install step. 10:28:13 INFO - Running pre-action listener: _resource_record_pre_action 10:28:13 INFO - Running main action method: install 10:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:13 INFO - Reading from file tmpfile_stdout 10:28:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:28:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:28:13 INFO - Reading from file tmpfile_stdout 10:28:13 INFO - Output received: 10:28:13 INFO - Usage: mozinstall [options] installer 10:28:13 INFO - Options: 10:28:13 INFO - -h, --help show this help message and exit 10:28:13 INFO - -d DEST, --destination=DEST 10:28:13 INFO - Directory to install application into. [default: 10:28:13 INFO - "/builds/slave/test"] 10:28:13 INFO - --app=APP Application being installed. [default: firefox] 10:28:13 INFO - mkdir: /builds/slave/test/build/application 10:28:13 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'] 10:28:13 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 10:28:30 INFO - Reading from file tmpfile_stdout 10:28:30 INFO - Output received: 10:28:30 INFO - /builds/slave/test/build/application/firefox/firefox 10:28:30 INFO - Running post-action listener: _resource_record_post_action 10:28:30 INFO - [mozharness: 2016-12-30 18:28:30.146926Z] Finished install step (success) 10:28:30 INFO - [mozharness: 2016-12-30 18:28:30.147172Z] Running run-tests step. 10:28:30 INFO - Running pre-action listener: _resource_record_pre_action 10:28:30 INFO - Running main action method: run_tests 10:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:28:30 INFO - Python 2.7.3 10:28:30 INFO - Return code: 0 10:28:30 INFO - grabbing minidump binary from tooltool 10:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:30 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 0x18083f0>, '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 0x1808cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18091a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:28:30 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 10:28:30 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 10:28:30 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 10:28:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:28:30 INFO - Return code: 0 10:28:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:28:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:28:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:28:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:28:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 10:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 10:28:30 INFO - Using env: {'DISPLAY': ':0', 10:28:30 INFO - 'HOME': '/home/cltbld', 10:28:30 INFO - 'LANG': 'en_US.UTF-8', 10:28:30 INFO - 'LANGUAGE': 'en_US:en', 10:28:30 INFO - 'LOGNAME': 'cltbld', 10:28:30 INFO - 'MAIL': '/var/mail/cltbld', 10:28:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:28:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:30 INFO - 'MOZ_NO_REMOTE': '1', 10:28:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:30 INFO - 'NO_EM_RESTART': '1', 10:28:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:30 INFO - 'PWD': '/builds/slave/test', 10:28:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:28:30 INFO - 'SHELL': '/bin/bash', 10:28:30 INFO - 'SHLVL': '1', 10:28:30 INFO - 'TERM': 'linux', 10:28:30 INFO - 'TMOUT': '86400', 10:28:30 INFO - 'USER': 'cltbld', 10:28:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1483120912.576580-606264268', 10:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:30 INFO - '_': '/tools/buildbot/bin/python'} 10:28:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 10:28:30 INFO - mozversion application_buildid: 20161230093919 10:28:30 INFO - mozversion application_changeset: a00632dc133aa17fbb42197911b8ce7833bf9386 10:28:30 INFO - mozversion application_display_name: Nightly 10:28:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:28:30 INFO - mozversion application_name: Firefox 10:28:30 INFO - mozversion application_remotingname: firefox 10:28:30 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 10:28:30 INFO - mozversion application_vendor: Mozilla 10:28:30 INFO - mozversion application_version: 53.0a1 10:28:30 INFO - mozversion platform_buildid: 20161230093919 10:28:30 INFO - mozversion platform_changeset: a00632dc133aa17fbb42197911b8ce7833bf9386 10:28:30 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 10:28:30 INFO - mozversion platform_version: 53.0a1 10:28:30 INFO - using testdate: 1483122510 10:28:30 INFO - actual date: 1483122510 10:28:30 INFO - starting webserver on 'localhost:44291' 10:28:30 INFO - SUITE-START | Running 2 tests 10:28:30 INFO - TEST-START | dromaeo_css 10:28:30 INFO - operating with platform_type : linux_ 10:28:30 INFO - Initialising browser for dromaeo_css test... 10:28:30 INFO - TEST-INFO | started process 10328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl27Fe9/profile http://localhost:44291/getInfo.html) 10:28:30 INFO - PROCESS | 10328 | 1483122510932 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 10:28:34 INFO - PROCESS | 10328 | __metrics Screen width/height:1600/1200 10:28:34 INFO - PROCESS | 10328 | colorDepth:24 10:28:34 INFO - PROCESS | 10328 | Browser inner width/height: 1024/697 10:28:34 INFO - PROCESS | 10328 | __metrics 10:28:35 INFO - PROCESS | 10328 | 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" 10:28:35 INFO - PROCESS | 10328 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:28:36 INFO - PROCESS | 10328 | console.error: PushService: 10:28:36 INFO - PROCESS | 10328 | stateChangeProcessEnqueue: Error transitioning state 10:28:36 INFO - PROCESS | 10328 | UnknownError 10:28:37 INFO - TEST-INFO | 10328: exit 0 10:28:37 INFO - Browser initialized. 10:28:37 INFO - Running cycle 1/1 for dromaeo_css test... 10:28:37 INFO - TEST-INFO | started process 10412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl27Fe9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:49 INFO - PROCESS | 10412 | RSS: Main: 151126016 10:28:49 INFO - PROCESS | 10412 | 10:31:53 INFO - PROCESS | 10412 | Cycle 1(1): loaded http://localhost:44291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44291/tests/dromaeo/cssquery-ext.html) 10:31:55 INFO - PROCESS | 10412 | RSS: Main: 303534080 10:31:55 INFO - PROCESS | 10412 | 10:33:38 INFO - PROCESS | 10412 | ************************* 10:33:38 INFO - PROCESS | 10412 | A coding exception was thrown and uncaught in a Task. 10:33:38 INFO - PROCESS | 10412 | 10:33:38 INFO - PROCESS | 10412 | Full message: ReferenceError: fetch is not defined 10:33:38 INFO - PROCESS | 10412 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 10:33:38 INFO - PROCESS | 10412 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 10:33:38 INFO - PROCESS | 10412 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 10:33:38 INFO - PROCESS | 10412 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 10:33:38 INFO - PROCESS | 10412 | TaskImpl@resource://gre/modules/Task.jsm:277:3 10:33:38 INFO - PROCESS | 10412 | asyncFunction@resource://gre/modules/Task.jsm:252:14 10:33:38 INFO - PROCESS | 10412 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 10:33:38 INFO - PROCESS | 10412 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 10:33:38 INFO - PROCESS | 10412 | TaskImpl@resource://gre/modules/Task.jsm:277:3 10:33:38 INFO - PROCESS | 10412 | asyncFunction@resource://gre/modules/Task.jsm:252:14 10:33:38 INFO - PROCESS | 10412 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 10:33:38 INFO - PROCESS | 10412 | 10:33:38 INFO - PROCESS | 10412 | ************************* 10:34:58 INFO - PROCESS | 10412 | Cycle 1(1): loaded http://localhost:44291/tests/dromaeo/cssquery-ext.html (next: http://localhost:44291/tests/dromaeo/cssquery-jquery.html) 10:34:58 INFO - PROCESS | 10412 | RSS: Main: 238915584 10:34:58 INFO - PROCESS | 10412 | 10:38:01 INFO - PROCESS | 10412 | Cycle 1(1): loaded http://localhost:44291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44291/tests/dromaeo/cssquery-mootools.html) 10:38:01 INFO - PROCESS | 10412 | RSS: Main: 209670144 10:38:01 INFO - PROCESS | 10412 | 10:41:03 INFO - PROCESS | 10412 | Cycle 1(1): loaded http://localhost:44291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44291/tests/dromaeo/cssquery-prototype.html) 10:41:04 INFO - PROCESS | 10412 | RSS: Main: 184459264 10:41:04 INFO - PROCESS | 10412 | 10:44:07 INFO - PROCESS | 10412 | Cycle 1(1): loaded http://localhost:44291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44291/tests/dromaeo/cssquery-yui.html) 10:44:08 INFO - PROCESS | 10412 | RSS: Main: 183631872 10:44:08 INFO - PROCESS | 10412 | 10:47:11 INFO - PROCESS | 10412 | Cycle 1(1): loaded http://localhost:44291/tests/dromaeo/cssquery-yui.html (next: http://localhost:44291/tests/dromaeo/cssquery-dojo.html) 10:47:11 INFO - PROCESS | 10412 | RSS: Main: 275324928 10:47:11 INFO - PROCESS | 10412 | 10:47:11 INFO - PROCESS | 10412 | __start_tp_report 10:47:11 INFO - PROCESS | 10412 | _x_x_mozilla_page_load 10:47:11 INFO - PROCESS | 10412 | _x_x_mozilla_page_load_details 10:47:11 INFO - PROCESS | 10412 | |i|pagename|runs| 10:47:11 INFO - PROCESS | 10412 | |0;dojo.html;2576.922692319231;2585.5087533368664;2613.046238123085;2630.7237740037294;2637.314298282446;4738.45507766607;4796.3045358423005;4799.592034677048;4805.207140821764;4830.686005409655;4849.466558678551;4853.344798452208;4862.513748625136;4917.139500587392;4968.652194346397;4382.846600368987;4412.139632771595;4453.042595841894;4506.188886000518;4529.841455549056;4099.73351732138;4517.367568540407;4547.386102876102;4579.404677391951;4629.1436084324505;4518.887027824298;4520.886977825548;4553.954460455386;4556.430446194226;4590.632749380042;4352.281873490871;4394.538573449806;4402.075564131536;4444.488883778375;4446.088551846864;4414.161309351213;4416.690831641787;4419.049904270597;4422.6682998774895;4427.977860110711;4829.1307564638355;4855.830045948375;4884.7069175849565;4930.161872481687;4930.704157750511;5236.266922630834;5242.318498595197;5242.318498595197;5242.895142097137;5290.470952904717;5066.341375621146;5270.156774915995;5273.920891186635;5278.762455689503;5281.815136470205;4763.857084287477;4845.248986407112;4869.537393947569;4880.585150262196;4931.3835770528685;5270.868228294246;5302.416734159239;5304.098303288451;5318.65428747138;5383.703896285742;5104.259882317117;5138.743062846843;5143.819966301162;5151.742412879416;5190.11767999441;5085.084684756779;5086.491350864884;5086.92369614456;5185.688858668492;5190.299309593157;5010.098182327216;5099.898002040012;5146.665466744649;5148.742562871917;5151.278820965068;5068.265101560327;5117.488251174927;5126.154184559506;5168.870778230499;5176.042432150064;4376.9124617508105;4383.276759334738;4383.49589797171;4384.232759267179;4420.889477763018;3698.2973235085246;3802.2015376770637;3811.5807261201244;3833.7124715646437;3834.041489627593;4376.146651402946;4451.6883818133065;4483.3723278741;4484.282514797616;4501.392312037833;5216.478352164753;5222.216667499905;5223.582113430916;5226.268322434862;5270.657407268592;4328.805203765838;4439.467263928284;4482.238019536687;4487.304467807495;4493.550644935545;4518.525554816697;4637.744924029211;4673.532646735299;4680.648951328664;4722.24444088951;4828.830990915301;4837.467878533429;4838.903221935612;4843.733594652328;4882.90234195307;5247.396549396868;5249.2651028855225;5249.7112658804135;5255.684658920477;5261.3686357637325;4639.884002899955;4696.624270058455;4707.693999889996;4713.811447542197;4741.83403580873;5056.469070747518;5060.367454068241;5064.7467626619255;5068.189089745623;5121.180611102206;5128.282040514257;5135.127028405105;5146.665466744649;5175.560077393464;5195.584353251656;5026.52248036436;5074.543291103819;5077.796888124433;5081.92377114351;5151.7166555839785;5085.923711144262;5094.388673359221;5094.974525127351;5098.388193416814;5150.40770311419;4887.535684110004;5003.974980125076;5008.724520151427;5012.77442515095;5015.899682006267;5014.774335154853;5044.4198917125;5045.369328833895;5047.394312682355;5048.116579598629;4918.754062296943;4973.278874563096;4976.477469865612;4976.651634385558;4980.576650984707 10:47:11 INFO - PROCESS | 10412 | |1;ext.html;507.6395759011102;522.1984254169847;528.0152515558482;538;551.7930775959015;28807.71192288079;38050.23899522011;39521.4071788923;39983.60016399835;43792;41224.38163427551;41681.58318416815;41694.791526042405;41822.37266441006;41847;7534.8116297092465;7637.961810190941;7794.688212471494;7801.843963120763;7806.258405451473;7514.549127052367;9878.753031174207;10134.89865101347;10139.543720532594;10432.530536125854;9811.313208075437;9863.26025548083;9870.901290987105;9878.802423951516;9884.308098433112;9777.217822574212;9828.410295382228;9830.852537211947;9837.213022958182;9849.704508864745;9887.653932112342;9970.15253703436;9971.650992215238;9974.551145198484;9979.501024948797;37675.24649506994;37873.43189852154;38033;38058.23883522342;38166.23667526634;3677.669009789105;3760.793156376398;3772.396416573335;3808.619138086169;3823.235352929425;28572.285692857637;28732.569011464635;28875.855620721763;29866.954656586917;29972.8501357494;3033.8331391773445;3041.102874651961;3083.5683004379407;3090.3819236152635;3169.9683003170135;223473;226039.8698006516;226862;226877;227719;52602.473975260524;52946.47053529415;53115;53125;53156.20265696017;55218;55221.72389138109;55376.723116384965;55419.722901385234;55420.16869746957;14036;14622.195779232245;14644.487442939446;14646.194459304628;14649.560513184622;9454.33819632633;9717.56270967794;10608.20438467118;10694.679159625224;11212.27120237182;16180.271887765079;16303.347866085462;16336;16360.918195409186;16386.344546218257;6384.58500197495;6564.540482166202;6570.8357291068105;6592.736290548324;6667.63328016954;772.9729459468891;778.4823092643329;791.6358475101517;804.4851295171095;805.8509175802495;27069.86465067662;27647.3198924863;27698.5845212322;28036.43927121446;28279.29301767472;921.5806807902522;922.5663937949154;935.0976307862945;938.0572524612857;949.0888746803147;14532.636684082983;14830.258487075604;14941;15119.244037798066;15178.848211517965;312886;346803;354538;354673;513478;43762.34356484655;44055.77972110183;44137.558624413985;44183.55816441859;44204.77897610491;1190.0836356006;1210.9031277497954;1219.8902098810972;1222.10175520992;1222.4560070768423;24387.14644987417;25057.373565661004;25167;26029.739702602732;26065.478690425705;36248.81875590605;36606.267874642894;36681;36731.44902826406;36770.632293677794;281187;282276;282953;283171;283278;20877;21581.35255942324;22180;22907;23197.76802231956;35666.46500302549;35673.28653426969;35784.642153578134;36105.277894442486;36254.4561831578;29350.559741603465;30092.699073009866;30629;31134.22164445907;31841.203969900936;28716.282092947844;28907.855460722563;29108.854455727585;29276.80423968168;30299.24251893632;30619.387612247185;30763.538546921365;30816.383672326876;30978.225544361572;31149.532757009118;25785.484290314464;27154.592681109403;27991.860040699667;28137;28221;21637.891810540845;21905.233316833834;22076.116955321606;22145;22151.224707135174 10:47:11 INFO - PROCESS | 10412 | |2;jquery.html;350.57580327803356;360.70962874885726;371.8159511042034;372.1997704934391;385.66061865558305;12797.936010319958;13661.795073073912;14104.294785260734;16503.33986640533;17144.14279286037;15002.549923502313;15353.462628807994;15402.537923862274;15919.522414327559;16379.344826206967;4292.401800714904;4585.9541404586025;4653.9069218615605;4678.111158879819;4684.601808846252;4528.615067719248;4612.492625811158;4617.676762626617;4619.376384188142;4619.74591397473;3624.528811254533;3774.8301326440237;5183.740812959356;5379.596530260226;5399.892002159954;5297.496737809902;5473.31583552056;5480.671159730429;5480.890382192354;5484.341878974548;5198.2202669599865;5250.947490525123;5256.9737151314;5260.789568417259;5264.473552644705;12072.336021518813;12134.757304853854;12523.373831308489;19739.309124180585;19875.90062049695;2154.4721543221854;2170.338046895696;2186.650135978236;2404.483036147237;2455.70531536215;8709.172628600272;8907.376483646147;9026.368154229207;9427.48148851813;9490.857637135448;1643.909584972826;1676.639522502668;1693.8390852868959;1712.9828701713072;1763.9647207055787;41142.588574114474;61522.0771688425;62298.68850655763;62602.37397626056;63967;9621.422714637145;9760.219182465386;9885.802283954281;9918.553665085088;10107.797844043078;13158.894576867846;13186.604401867959;13194.274314912773;13196.47214111444;13211.207327560378;7186.6047367395295;7218.927810721931;7314.08573928259;7478.214787447239;7515.060617422822;6932.826679332956;6975;6998.93001069993;7139.321764432474;7142.250063743336;4315.705288413464;4341.674374421931;4353.564643535621;4363.36731173978;4438.977805111019;1805.2237537858584;1843.262694922015;1855.4526414707693;1862.7299041639158;1871.2889102141098;830.767385132164;844.2697067036969;862.2067697718114;867.5402036920442;883.5449743382163;13316.800247996287;13374;13391;13441.39513721885;13486.730265394834;828.5774255129927;840.6469282901074;842.3177226446597;848.9490630562186;859.6260626627437;7372.557646541225;7374.225706300868;7407.333339999426;7408;7437.0331856858265;321347;323758.8617024432;329109;329998;330224;50195.74902125539;50968.74515627398;68418.65790671014;68959.31040689629;70867;872.7687162901836;890.6303883888244;909.0318810466831;911.166282851197;913.3332667153015;11960.58137965167;11974.161808673309;12094.334811585448;12329.50681972711;12401.193922395016;32922.67077329196;33253;33528.832355838065;33655.14896680706;34441.655583444845;44003.77998109989;45288.32067518924;46591.534084660074;47036;49895;6744.0558321834005;6807.863842723217;6901.275366086689;7036.753713620204;7218.422526197996;10116.89883101189;11421.257618254787;11477.253978491372;11722.648320550397;12110;9995.500224988577;10250.411186266141;10326.690199294033;10391.064804167661;10780.245382823126;10225.590976360862;10345.551622772668;10463.738406539593;10494.370337779757;10523.894761052292;10309.587616495557;10367.948160259451;10380.532876020447;10479.528421220912;10629.149668026694;6785.525013249223;6911.654417279216;6952.721891124298;6962.617056061965;7321.121465424183;8149.877751833608;9641.951790241004;9798.461084640414;9832.852507212254;10102.949485252526 10:47:11 INFO - PROCESS | 10412 | |3;mootools.html;1309.8297221361222;1324.960251192464;1330.2151730479015;1331.7536255792686;1347.2657401716065;6848.349406806352;7261.927380726192;7264.309890560401;7269.236730143338;7304;6400.199975003125;6598.769043083493;6919.100516932792;7061.187963384213;7071.85856282874;2044.7546294444687;2072.3264938894918;2074.9273775417864;2074.968875466862;2078.0752565108533;2074.553970896257;2114.3762590035976;2116.608427440921;2127.287358734826;2130.084063852543;1788.445581869618;1851.9259229630798;1980.3167907072109;2060.6702927531596;2068.7103805467245;2052.189385192848;2091.4562213824365;2091.592139532792;2096.224396973122;2096.4863608416035;2071.18188315616;2079.1371580793952;2090.7595626502994;2099.9160033598637;2108.1778106538463;7152.213256541776;7189.245129261404;7207.5675459472595;7214.603196824172;7219.927800721978;4223.239816832969;4340.60934515895;4343.717658352229;4348.543402942677;4352.934705979413;2698.7031426543263;2816.0847724489417;2816.310004049001;2829.3351062500296;2832.065418411919;1043.519980808829;1060.872695276564;1090.967270981864;1098.8681358236984;1117.6032508459461;9360.531973401303;9559.952200239093;9613.279004074722;9625.278104142217;9626.518674066268;3953.0512676957323;3955.5759926426463;3964.682825373963;3969.364901615728;4031.7177797554477;8352.081271060179;8355.582220888931;8356.206160414751;8358.540280284522;8362.874556881652;4384.539623339567;4386.495553011381;4387.14450682114;4389.012472193731;4389.209942210433;3896.902577435587;3934.8426062957733;3938.212357528506;3958.4062390641056;3960.6237407446247;3253.674632536775;3328.2012317043736;3374.088995971074;3392.8982130536124;3467.081223475781;1026.8459731040405;1042.4839704346398;1062.2829590026702;1064.41989115932;1068;634.4924060751381;636.2619361540683;640.3500447046159;662.5130529061137;685.9108315918899;4436.157130145262;4499.942513509322;4596.632269418438;4636.423615970519;4735.384400028043;513.1968469345462;514.675754274812;514.7503460821498;516.2411255454476;639.2169592249458;2903.3612605226817;2921.0944607171846;3038.483457812177;3101.379724055153;3174.904752857418;7908.52548847071;7983.72056978003;8322.8335433291;8339.291160251447;8353.707620233263;8504.829903402022;8509.446885952393;8511.914880851113;8514.403991720521;8517.105703901001;6604.5046621502615;6746.763863264664;6772.661366931634;6774.254831968479;6783.050372947791;4683.391159149289;4685.226937555265;4695.342652028787;4796.688215265996;4799.736014519235;7892.723754668559;7929.920700792918;7955.721549745731;7956.681732730626;8018.398620103399;7878.369730421437;8030.5181689098845;8031.959840200761;8192;8196.918030819854;6103.05402662588;6217.96891015542;6220.03589443637;6221.440070393686;6222.81331560054;6852.931470685428;6883.896741548981;6901.1718593769065;6917.481188910751;6927.792166235021;6241.188645476059;6259.906101408392;6264.937350626617;6294.8111556653375;6393.520485963479;6053.364396738279;6103.267607887082;6119.204503414528;6131.570790044832;6231.4391704746795;5402.621816472809;5531.861703457445;5570;5576.498115169492;5647.378788333198;4050.6556942660204;4124.608162224584;4125.752454852718;4197.370394440858;4297.76362300064;4139.689523285705;4239.173361194537;4298.656107511329;4342.739435633872;4411.426514553087 10:47:11 INFO - PROCESS | 10412 | |4;prototype.html;345.6526191177867;350.95546137259277;352.80771979271293;357.12326239083035;359.57031347539686;4926;4935.77788999495;4947.406311242651;4960.305557221992;4979.626528010395;4850.296706977495;4864.537868902457;4866.805327786884;4878.4389795173565;4897.853064408065;3441.5698037745283;3688.409854423293;3809.3333666608232;3895.6493915547594;3950.9604903950953;3887.261420330128;3890.396988466792;3906.980465097685;3909.5534652178735;3912.647861692447;3878.747881387715;3890.319194141028;3892.1048158923463;3892.746971446861;3896.5324161100707;3720.274546463441;3817.141143242776;3820.656140947328;3903.668188203992;3911.9022024449473;3492;3493.7030352420074;3502.176988407722;3504.4392897136336;3514.2268700885766;4714.57568818808;4720;4723.315119307716;4732.905341893177;4783.4977327380475;4345.804903651489;4467.396901418332;4474.149911516802;4474.38248624555;4477.3731677565165;5029.918567507967;5041.546260836506;5057.620678449131;5070.315507406527;5101.393061185715;3791;3799.126200973764;3809.904752381185;3848.6536211741077;3869.7484663496784;5072.9746351268;5244.187150991603;5347.422510359454;5351.892962140774;5352.652077614943;3831;3920.666743326792;3937.940930886039;3951.920961580752;3961.9009524761536;3979.900502487461;3985.4855155041478;3985.6811455083525;3994.3409337459575;4015.554400415848;4454.910901781946;4458.684688017042;4466.352378905106;4473.731576105444;4489.506154323022;4944.53026962438;5089.9745501273;5111.616628752859;5111.821086262037;5133.794648214104;1333.9061969185368;1342.9597112086653;1343.234356416833;1351.6283022168982;1360.4490181476517;910.4082346474712;933.9252859771202;939.9013103624021;940.9884374297658;981.5435822342645;4332.415123958225;4333.198358303661;4337.0024894273865;4346.413234213404;4354.629856462237;4961.975190124099;4964.659541923733;4994.875128121754;5019.949800502021;5035.3131700879885;4301.225779359683;4318.222719910384;4318.546552611931;4323.69734118615;4333.674974376934;2557.693076830792;2700.2169370882225;2715.823471474348;2719.619253304539;2721.6461859958476;4685.718856868599;4712.24604063355;4724.480307166209;4728.40894888139;4780.856574302707;5056.949430505648;5235.188545775411;5254.500822421864;5270.8155214567305;5271.868203294948;4841.467438581753;4859.538343857328;4880.804767809319;4881.365422495053;4888.364512613338;5269.446708095595;5291;5295.338082739658;5321.3880403754065;5329.307190065267;4967.850964471072;5241.868953276046;5244.292020577326;5260.237265596544;5266.552343050884;4634.884127896829;4765.475797662324;4781.784819683053;4867.853964381075;4893.412790465167;3892.8832135035996;3936.8031598419393;3944.4674968878835;3956.7032472565247;3964.306246406925;5255.7123504741585;5287.233351163983;5295.099833028317;5300.416954135119;5313.654612450178;4922.310876477224;5045.445001049955;5085.194491205775;5157.303763991963;5166.767495462788;5013.172826483736;5048.798048078036;5052.469490703424;5058.140116180185;5063.594912406925;4989.525995030466;5008.347245409079;5017.147084995487;5020.196768517019;5063.721495317793;4887.36464259644;5108.642395032312;5118.539331460038;5128.256402821645;5160.251763494347;5001.349824522788;5003.524665156804;5004.249362595494;5014.197728363444;5015.548600625962 10:47:11 INFO - PROCESS | 10412 | |5;yui.html;644.4296797334358;680.9182898052235;731.9268073192682;749.4454103963067;754.675489539498;11907.345096019726;12469.438875250613;12595.811062834042;12645.873541264596;12808.423620937057;13447.058705890568;13673.794893076612;13728.931355343235;13731.17612943224;13734.17594944304;661.4113439039235;685.9588424694509;796.2157275084038;812.6708682983401;829.3655353654459;815.4169768615438;832.8958880139983;833.1793183714037;833.5832083958021;833.7165363776345;885.2431171348501;888.4491615198554;889;889.1641856654757;890.0921060518267;705.1855107351017;728.9416846652255;842.2630198576246;885.6767279942839;886.4326830828243;639.0414378432351;644.6937704590329;644.935506449356;645.1741770533724;645.6739346629969;13143.408546615425;13152;13196;13243.271620060892;13258.337083145803;12906.677333066655;12907.999999999905;12918.483260669562;12920;13076.738465230643;11727.7068073298;11729.941350293278;11799.233049851731;11869.10981676369;11888.643340699793;3937.8424863005444;3962.821673024721;3987.2623564640635;4057.3913912913004;4111.259973204822;60413.395866041654;60464;60519.394806051816;60573.39426605766;61081.389186108456;9851.261155413373;10064.798704025878;10352.120069794151;10420.68737937863;10619.097376723064;19585.314513991943;19679.704804427944;19759.308424205083;19910.800891991184;19969.500762481053;6561.80314590563;6563.50773691975;6627.072209890619;6630.900536491957;6715.731370745213;3499.61504234534;3559.750817442754;3577.982110089485;3581.982090089533;3692.1692619160476;2767.764739997123;2829.2643912582876;2833.447477741862;3141.9214519637194;3284.540164376989;565.2877374508149;566.6260268223035;566.8412844403574;569.7749388991325;579.8289504596154;582.8018473718871;599.1103211730576;602.6866029664637;604.3291945940003;611.4191518057863;7741.109772376249;7940.09437734951;8066.556339401389;8078.838423231502;8101.149379315205;484.12373603777274;485.6964397251718;491.49867135521566;498.7905079866465;504.55599072815687;3758.8684396046006;3937.27160475313;4041.0907545802547;4059.109984955292;4071.918561628751;62809.68595156995;63929.68035159794;64513;65116.34883651198;66715;52306;54294;55117;55454.445455545734;55598.16602750962;50580.494195058316;50913.23630145477;51288;51478.74260628673;51918.48081519137;7529.247075292427;7675.808104797425;7732.729354472566;7858.410619203697;8019.6391162398995;34330.82834585811;34800.30399391947;35689.82155089208;36034.819825900704;36149.457758133125;35358;43651.56348436602;44406.55593444024;44527.87553991346;45573.54426455826;9153.725388238363;9321.580528876082;9403.670871519464;9511.619535218513;9878.506074696093;10570.10154136907;10723.892761072602;10732.570697172338;11328.150388720715;11508.136889733136;10547.156227501935;10911.945440272748;10921.672349829518;11227.7754444909;11246.550137994389;10159.339642923187;10325.845112323172;10380.584776608852;10456.372617642966;10729.088027517748;10218.846717299395;10314.845277320695;10397;10646.307989980627;10807.891921081004;8652.307815374881;8693.652253909773;8775.956120219358;8871.955640221757;9166.312526560401;8368.113626099743;8532.488050716976;8534.70128545498;8599.14008599135;8720.43317184381 10:47:11 INFO - PROCESS | 10412 | __end_tp_report 10:47:11 INFO - PROCESS | 10412 | __start_cc_report 10:47:11 INFO - PROCESS | 10412 | _x_x_mozilla_cycle_collect,1634 10:47:11 INFO - PROCESS | 10412 | __end_cc_report 10:47:11 INFO - PROCESS | 10412 | __startTimestamp1483123631774__endTimestamp 10:47:11 INFO - PROCESS | 10412 | 10:47:11 INFO - PROCESS | 10412 | ------- Summary: start ------- 10:47:11 INFO - PROCESS | 10412 | Number of tests: 6 10:47:11 INFO - PROCESS | 10412 | 10:47:11 INFO - PROCESS | 10412 | [#0] dojo.html Cycles:165 Average:4782.99 Median:4918.75 stddev:521.33 (10.6%) stddev-sans-first:493.36 10:47:11 INFO - PROCESS | 10412 | Values: 2576.9 2585.5 2613.0 2630.7 2637.3 4738.5 4796.3 4799.6 4805.2 4830.7 4849.5 4853.3 4862.5 4917.1 4968.7 4382.8 4412.1 4453.0 4506.2 4529.8 4099.7 4517.4 4547.4 4579.4 4629.1 4518.9 4520.9 4554.0 4556.4 4590.6 4352.3 4394.5 4402.1 4444.5 4446.1 4414.2 4416.7 4419.0 4422.7 4428.0 4829.1 4855.8 4884.7 4930.2 4930.7 5236.3 5242.3 5242.3 5242.9 5290.5 5066.3 5270.2 5273.9 5278.8 5281.8 4763.9 4845.2 4869.5 4880.6 4931.4 5270.9 5302.4 5304.1 5318.7 5383.7 5104.3 5138.7 5143.8 5151.7 5190.1 5085.1 5086.5 5086.9 5185.7 5190.3 5010.1 5099.9 5146.7 5148.7 5151.3 5068.3 5117.5 5126.2 5168.9 5176.0 4376.9 4383.3 4383.5 4384.2 4420.9 3698.3 3802.2 3811.6 3833.7 3834.0 4376.1 4451.7 4483.4 4484.3 4501.4 5216.5 5222.2 5223.6 5226.3 5270.7 4328.8 4439.5 4482.2 4487.3 4493.6 4518.5 4637.7 4673.5 4680.6 4722.2 4828.8 4837.5 4838.9 4843.7 4882.9 5247.4 5249.3 5249.7 5255.7 5261.4 4639.9 4696.6 4707.7 4713.8 4741.8 5056.5 5060.4 5064.7 5068.2 5121.2 5128.3 5135.1 5146.7 5175.6 5195.6 5026.5 5074.5 5077.8 5081.9 5151.7 5085.9 5094.4 5095.0 5098.4 5150.4 4887.5 5004.0 5008.7 5012.8 5015.9 5014.8 5044.4 5045.4 5047.4 5048.1 4918.8 4973.3 4976.5 4976.7 4980.6 10:47:11 INFO - PROCESS | 10412 | 10:47:11 INFO - PROCESS | 10412 | [#1] ext.html Cycles:180 Average:44231.80 Median:195169.73 stddev:80222.92 (41.1%) stddev-sans-first:80380.79 10:47:11 INFO - PROCESS | 10412 | Values: 507.6 522.2 528.0 538.0 551.8 28807.7 38050.2 39521.4 39983.6 43792.0 41224.4 41681.6 41694.8 41822.4 41847.0 7534.8 7638.0 7794.7 7801.8 7806.3 7514.5 9878.8 10134.9 10139.5 10432.5 9811.3 9863.3 9870.9 9878.8 9884.3 9777.2 9828.4 9830.9 9837.2 9849.7 9887.7 9970.2 9971.7 9974.6 9979.5 37675.2 37873.4 38033.0 38058.2 38166.2 3677.7 3760.8 3772.4 3808.6 3823.2 28572.3 28732.6 28875.9 29867.0 29972.9 3033.8 3041.1 3083.6 3090.4 3170.0 223473.0 226039.9 226862.0 226877.0 227719.0 52602.5 52946.5 53115.0 53125.0 53156.2 55218.0 55221.7 55376.7 55419.7 55420.2 14036.0 14622.2 14644.5 14646.2 14649.6 9454.3 9717.6 10608.2 10694.7 11212.3 16180.3 16303.3 16336.0 16360.9 16386.3 6384.6 6564.5 6570.8 6592.7 6667.6 773.0 778.5 791.6 804.5 805.9 27069.9 27647.3 27698.6 28036.4 28279.3 921.6 922.6 935.1 938.1 949.1 14532.6 14830.3 14941.0 15119.2 15178.8 312886.0 346803.0 354538.0 354673.0 513478.0 43762.3 44055.8 44137.6 44183.6 44204.8 1190.1 1210.9 1219.9 1222.1 1222.5 24387.1 25057.4 25167.0 26029.7 26065.5 36248.8 36606.3 36681.0 36731.4 36770.6 281187.0 282276.0 282953.0 283171.0 283278.0 20877.0 21581.4 22180.0 22907.0 23197.8 35666.5 35673.3 35784.6 36105.3 36254.5 29350.6 30092.7 30629.0 31134.2 31841.2 28716.3 28907.9 29108.9 29276.8 30299.2 30619.4 30763.5 30816.4 30978.2 31149.5 25785.5 27154.6 27991.9 28137.0 28221.0 21637.9 21905.2 22076.1 22145.0 22151.2 10:47:11 INFO - PROCESS | 10412 | 10:47:11 INFO - PROCESS | 10412 | [#2] jquery.html Cycles:180 Average:21002.92 Median:4483.80 stddev:53905.16 (1202.2%) stddev-sans-first:54034.08 10:47:11 INFO - PROCESS | 10412 | Values: 350.6 360.7 371.8 372.2 385.7 12797.9 13661.8 14104.3 16503.3 17144.1 15002.5 15353.5 15402.5 15919.5 16379.3 4292.4 4586.0 4653.9 4678.1 4684.6 4528.6 4612.5 4617.7 4619.4 4619.7 3624.5 3774.8 5183.7 5379.6 5399.9 5297.5 5473.3 5480.7 5480.9 5484.3 5198.2 5250.9 5257.0 5260.8 5264.5 12072.3 12134.8 12523.4 19739.3 19875.9 2154.5 2170.3 2186.7 2404.5 2455.7 8709.2 8907.4 9026.4 9427.5 9490.9 1643.9 1676.6 1693.8 1713.0 1764.0 41142.6 61522.1 62298.7 62602.4 63967.0 9621.4 9760.2 9885.8 9918.6 10107.8 13158.9 13186.6 13194.3 13196.5 13211.2 7186.6 7218.9 7314.1 7478.2 7515.1 6932.8 6975.0 6998.9 7139.3 7142.3 4315.7 4341.7 4353.6 4363.4 4439.0 1805.2 1843.3 1855.5 1862.7 1871.3 830.8 844.3 862.2 867.5 883.5 13316.8 13374.0 13391.0 13441.4 13486.7 828.6 840.6 842.3 848.9 859.6 7372.6 7374.2 7407.3 7408.0 7437.0 321347.0 323758.9 329109.0 329998.0 330224.0 50195.7 50968.7 68418.7 68959.3 70867.0 872.8 890.6 909.0 911.2 913.3 11960.6 11974.2 12094.3 12329.5 12401.2 32922.7 33253.0 33528.8 33655.1 34441.7 44003.8 45288.3 46591.5 47036.0 49895.0 6744.1 6807.9 6901.3 7036.8 7218.4 10116.9 11421.3 11477.3 11722.6 12110.0 9995.5 10250.4 10326.7 10391.1 10780.2 10225.6 10345.6 10463.7 10494.4 10523.9 10309.6 10367.9 10380.5 10479.5 10629.1 6785.5 6911.7 6952.7 6962.6 7321.1 8149.9 9642.0 9798.5 9832.9 10102.9 10:47:11 INFO - PROCESS | 10412 | 10:47:11 INFO - PROCESS | 10412 | [#3] mootools.html Cycles:180 Average:4670.75 Median:4690.28 stddev:2564.37 (54.7%) stddev-sans-first:2559.12 10:47:11 INFO - PROCESS | 10412 | Values: 1309.8 1325.0 1330.2 1331.8 1347.3 6848.3 7261.9 7264.3 7269.2 7304.0 6400.2 6598.8 6919.1 7061.2 7071.9 2044.8 2072.3 2074.9 2075.0 2078.1 2074.6 2114.4 2116.6 2127.3 2130.1 1788.4 1851.9 1980.3 2060.7 2068.7 2052.2 2091.5 2091.6 2096.2 2096.5 2071.2 2079.1 2090.8 2099.9 2108.2 7152.2 7189.2 7207.6 7214.6 7219.9 4223.2 4340.6 4343.7 4348.5 4352.9 2698.7 2816.1 2816.3 2829.3 2832.1 1043.5 1060.9 1091.0 1098.9 1117.6 9360.5 9560.0 9613.3 9625.3 9626.5 3953.1 3955.6 3964.7 3969.4 4031.7 8352.1 8355.6 8356.2 8358.5 8362.9 4384.5 4386.5 4387.1 4389.0 4389.2 3896.9 3934.8 3938.2 3958.4 3960.6 3253.7 3328.2 3374.1 3392.9 3467.1 1026.8 1042.5 1062.3 1064.4 1068.0 634.5 636.3 640.4 662.5 685.9 4436.2 4499.9 4596.6 4636.4 4735.4 513.2 514.7 514.8 516.2 639.2 2903.4 2921.1 3038.5 3101.4 3174.9 7908.5 7983.7 8322.8 8339.3 8353.7 8504.8 8509.4 8511.9 8514.4 8517.1 6604.5 6746.8 6772.7 6774.3 6783.1 4683.4 4685.2 4695.3 4796.7 4799.7 7892.7 7929.9 7955.7 7956.7 8018.4 7878.4 8030.5 8032.0 8192.0 8196.9 6103.1 6218.0 6220.0 6221.4 6222.8 6852.9 6883.9 6901.2 6917.5 6927.8 6241.2 6259.9 6264.9 6294.8 6393.5 6053.4 6103.3 6119.2 6131.6 6231.4 5402.6 5531.9 5570.0 5576.5 5647.4 4050.7 4124.6 4125.8 4197.4 4297.8 4139.7 4239.2 4298.7 4342.7 4411.4 10:47:11 INFO - PROCESS | 10412 | 10:47:11 INFO - PROCESS | 10412 | [#4] prototype.html Cycles:180 Average:4251.29 Median:4781.32 stddev:1194.35 (25.0%) stddev-sans-first:1161.17 10:47:11 INFO - PROCESS | 10412 | Values: 345.7 351.0 352.8 357.1 359.6 4926.0 4935.8 4947.4 4960.3 4979.6 4850.3 4864.5 4866.8 4878.4 4897.9 3441.6 3688.4 3809.3 3895.6 3951.0 3887.3 3890.4 3907.0 3909.6 3912.6 3878.7 3890.3 3892.1 3892.7 3896.5 3720.3 3817.1 3820.7 3903.7 3911.9 3492.0 3493.7 3502.2 3504.4 3514.2 4714.6 4720.0 4723.3 4732.9 4783.5 4345.8 4467.4 4474.1 4474.4 4477.4 5029.9 5041.5 5057.6 5070.3 5101.4 3791.0 3799.1 3809.9 3848.7 3869.7 5073.0 5244.2 5347.4 5351.9 5352.7 3831.0 3920.7 3937.9 3951.9 3961.9 3979.9 3985.5 3985.7 3994.3 4015.6 4454.9 4458.7 4466.4 4473.7 4489.5 4944.5 5090.0 5111.6 5111.8 5133.8 1333.9 1343.0 1343.2 1351.6 1360.4 910.4 933.9 939.9 941.0 981.5 4332.4 4333.2 4337.0 4346.4 4354.6 4962.0 4964.7 4994.9 5019.9 5035.3 4301.2 4318.2 4318.5 4323.7 4333.7 2557.7 2700.2 2715.8 2719.6 2721.6 4685.7 4712.2 4724.5 4728.4 4780.9 5056.9 5235.2 5254.5 5270.8 5271.9 4841.5 4859.5 4880.8 4881.4 4888.4 5269.4 5291.0 5295.3 5321.4 5329.3 4967.9 5241.9 5244.3 5260.2 5266.6 4634.9 4765.5 4781.8 4867.9 4893.4 3892.9 3936.8 3944.5 3956.7 3964.3 5255.7 5287.2 5295.1 5300.4 5313.7 4922.3 5045.4 5085.2 5157.3 5166.8 5013.2 5048.8 5052.5 5058.1 5063.6 4989.5 5008.3 5017.1 5020.2 5063.7 4887.4 5108.6 5118.5 5128.3 5160.3 5001.3 5003.5 5004.2 5014.2 5015.5 10:47:11 INFO - PROCESS | 10412 | 10:47:11 INFO - PROCESS | 10412 | [#5] yui.html Cycles:180 Average:14337.18 Median:51100.62 stddev:17837.85 (34.9%) stddev-sans-first:17858.26 10:47:11 INFO - PROCESS | 10412 | Values: 644.4 680.9 731.9 749.4 754.7 11907.3 12469.4 12595.8 12645.9 12808.4 13447.1 13673.8 13728.9 13731.2 13734.2 661.4 686.0 796.2 812.7 829.4 815.4 832.9 833.2 833.6 833.7 885.2 888.4 889.0 889.2 890.1 705.2 728.9 842.3 885.7 886.4 639.0 644.7 644.9 645.2 645.7 13143.4 13152.0 13196.0 13243.3 13258.3 12906.7 12908.0 12918.5 12920.0 13076.7 11727.7 11729.9 11799.2 11869.1 11888.6 3937.8 3962.8 3987.3 4057.4 4111.3 60413.4 60464.0 60519.4 60573.4 61081.4 9851.3 10064.8 10352.1 10420.7 10619.1 19585.3 19679.7 19759.3 19910.8 19969.5 6561.8 6563.5 6627.1 6630.9 6715.7 3499.6 3559.8 3578.0 3582.0 3692.2 2767.8 2829.3 2833.4 3141.9 3284.5 565.3 566.6 566.8 569.8 579.8 582.8 599.1 602.7 604.3 611.4 7741.1 7940.1 8066.6 8078.8 8101.1 484.1 485.7 491.5 498.8 504.6 3758.9 3937.3 4041.1 4059.1 4071.9 62809.7 63929.7 64513.0 65116.3 66715.0 52306.0 54294.0 55117.0 55454.4 55598.2 50580.5 50913.2 51288.0 51478.7 51918.5 7529.2 7675.8 7732.7 7858.4 8019.6 34330.8 34800.3 35689.8 36034.8 36149.5 35358.0 43651.6 44406.6 44527.9 45573.5 9153.7 9321.6 9403.7 9511.6 9878.5 10570.1 10723.9 10732.6 11328.2 11508.1 10547.2 10911.9 10921.7 11227.8 11246.6 10159.3 10325.8 10380.6 10456.4 10729.1 10218.8 10314.8 10397.0 10646.3 10807.9 8652.3 8693.7 8776.0 8872.0 9166.3 8368.1 8532.5 8534.7 8599.1 8720.4 10:47:11 INFO - PROCESS | 10412 | -------- Summary: end -------- 10:47:11 INFO - PROCESS | 10412 | 10:47:12 INFO - TEST-INFO | 10412: exit 0 10:47:12 INFO - TEST-OK | dromaeo_css | took 1122200ms 10:47:12 INFO - TEST-START | kraken 10:47:12 INFO - operating with platform_type : linux_ 10:47:12 INFO - Initialising browser for kraken test... 10:47:12 INFO - TEST-INFO | started process 10712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3kUNE5/profile http://localhost:44291/getInfo.html) 10:47:13 INFO - PROCESS | 10712 | 1483123633132 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 10:47:17 INFO - PROCESS | 10712 | __metrics Screen width/height:1600/1200 10:47:17 INFO - PROCESS | 10712 | colorDepth:24 10:47:17 INFO - PROCESS | 10712 | Browser inner width/height: 1024/697 10:47:17 INFO - PROCESS | 10712 | __metrics 10:47:17 INFO - PROCESS | 10712 | 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" 10:47:17 INFO - PROCESS | 10712 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:47:18 INFO - TEST-INFO | 10712: exit 0 10:47:18 INFO - Browser initialized. 10:47:18 INFO - Running cycle 1/1 for kraken test... 10:47:18 INFO - TEST-INFO | started process 10794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3kUNE5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:30 INFO - PROCESS | 10794 | RSS: Main: 151572480 10:47:30 INFO - PROCESS | 10794 | 10:47:33 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44291/tests/kraken/driver.html?testName=audio-beat-detection) 10:47:34 INFO - PROCESS | 10794 | RSS: Main: 205541376 10:47:34 INFO - PROCESS | 10794 | 10:47:37 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44291/tests/kraken/driver.html?testName=audio-dft) 10:47:37 INFO - PROCESS | 10794 | RSS: Main: 185409536 10:47:37 INFO - PROCESS | 10794 | 10:47:41 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44291/tests/kraken/driver.html?testName=audio-fft) 10:47:41 INFO - PROCESS | 10794 | RSS: Main: 268107776 10:47:41 INFO - PROCESS | 10794 | 10:47:43 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44291/tests/kraken/driver.html?testName=audio-oscillator) 10:47:44 INFO - PROCESS | 10794 | RSS: Main: 179765248 10:47:44 INFO - PROCESS | 10794 | 10:47:46 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:47:47 INFO - PROCESS | 10794 | RSS: Main: 182476800 10:47:47 INFO - PROCESS | 10794 | 10:47:50 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44291/tests/kraken/driver.html?testName=imaging-darkroom) 10:47:51 INFO - PROCESS | 10794 | RSS: Main: 221999104 10:47:51 INFO - PROCESS | 10794 | 10:47:54 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44291/tests/kraken/driver.html?testName=imaging-desaturate) 10:47:55 INFO - PROCESS | 10794 | RSS: Main: 216059904 10:47:55 INFO - PROCESS | 10794 | 10:47:58 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44291/tests/kraken/driver.html?testName=json-parse-financial) 10:47:58 INFO - PROCESS | 10794 | RSS: Main: 217161728 10:47:58 INFO - PROCESS | 10794 | 10:48:00 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:48:00 INFO - PROCESS | 10794 | RSS: Main: 181104640 10:48:00 INFO - PROCESS | 10794 | 10:48:02 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44291/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:48:03 INFO - PROCESS | 10794 | RSS: Main: 188059648 10:48:03 INFO - PROCESS | 10794 | 10:48:05 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:48:06 INFO - PROCESS | 10794 | RSS: Main: 196239360 10:48:06 INFO - PROCESS | 10794 | 10:48:09 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:48:09 INFO - PROCESS | 10794 | RSS: Main: 205312000 10:48:09 INFO - PROCESS | 10794 | 10:48:12 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:48:13 INFO - PROCESS | 10794 | RSS: Main: 202059776 10:48:13 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | Cycle 1(1): loaded http://localhost:44291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44291/tests/kraken/driver.html?testName=ai-astar) 10:48:15 INFO - PROCESS | 10794 | RSS: Main: 253476864 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | __start_tp_report 10:48:15 INFO - PROCESS | 10794 | _x_x_mozilla_page_load 10:48:15 INFO - PROCESS | 10794 | _x_x_mozilla_page_load_details 10:48:15 INFO - PROCESS | 10794 | |i|pagename|runs| 10:48:15 INFO - PROCESS | 10794 | |0;ai-astar;113;114;114;117;115;116;116;115;116;115 10:48:15 INFO - PROCESS | 10794 | |1;audio-beat-detection;152;129;128;180;130;129;138;127;146;131 10:48:15 INFO - PROCESS | 10794 | |2;audio-dft;162;161;161;163;162;163;162;163;162;162 10:48:15 INFO - PROCESS | 10794 | |3;audio-fft;76;76;77;113;78;78;78;77;92;79 10:48:15 INFO - PROCESS | 10794 | |4;audio-oscillator;85;86;114;86;84;86;100;85;85;108 10:48:15 INFO - PROCESS | 10794 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;117 10:48:15 INFO - PROCESS | 10794 | |6;imaging-darkroom;149;148;149;149;149;149;148;149;149;149 10:48:15 INFO - PROCESS | 10794 | |7;imaging-desaturate;95;95;95;96;98;95;96;96;95;95 10:48:15 INFO - PROCESS | 10794 | |8;json-parse-financial;65;65;65;65;65;65;66;67;66;65 10:48:15 INFO - PROCESS | 10794 | |9;json-stringify-tinderbox;69;67;66;67;69;67;70;68;68;67 10:48:15 INFO - PROCESS | 10794 | |10;stanford-crypto-aes;86;84;88;85;95;87;85;85;84;84 10:48:15 INFO - PROCESS | 10794 | |11;stanford-crypto-ccm;147;146;146;141;137;132;143;133;179;146 10:48:15 INFO - PROCESS | 10794 | |12;stanford-crypto-pbkdf2;176;178;175;176;178;175;180;172;179;175 10:48:15 INFO - PROCESS | 10794 | |13;stanford-crypto-sha256-iterative;68;71;69;68;68;69;68;68;77;66 10:48:15 INFO - PROCESS | 10794 | __end_tp_report 10:48:15 INFO - PROCESS | 10794 | __start_cc_report 10:48:15 INFO - PROCESS | 10794 | _x_x_mozilla_cycle_collect,1784 10:48:15 INFO - PROCESS | 10794 | __end_cc_report 10:48:15 INFO - PROCESS | 10794 | __startTimestamp1483123695598__endTimestamp 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | ------- Summary: start ------- 10:48:15 INFO - PROCESS | 10794 | Number of tests: 14 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.50 stddev:1.20 (1.0%) stddev-sans-first:1.00 10:48:15 INFO - PROCESS | 10794 | Values: 113.0 114.0 114.0 117.0 115.0 116.0 116.0 115.0 116.0 115.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:134.50 stddev:16.70 (12.4%) stddev-sans-first:17.04 10:48:15 INFO - PROCESS | 10794 | Values: 152.0 129.0 128.0 180.0 130.0 129.0 138.0 127.0 146.0 131.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:48:15 INFO - PROCESS | 10794 | Values: 162.0 161.0 161.0 163.0 162.0 163.0 162.0 163.0 162.0 162.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#3] audio-fft Cycles:10 Average:82.40 Median:78.00 stddev:11.73 (15.0%) stddev-sans-first:12.21 10:48:15 INFO - PROCESS | 10794 | Values: 76.0 76.0 77.0 113.0 78.0 78.0 78.0 77.0 92.0 79.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:85.00 stddev:11.17 (13.1%) stddev-sans-first:11.57 10:48:15 INFO - PROCESS | 10794 | Values: 85.0 86.0 114.0 86.0 84.0 86.0 100.0 85.0 85.0 108.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:48:15 INFO - PROCESS | 10794 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 10:48:15 INFO - PROCESS | 10794 | Values: 149.0 148.0 149.0 149.0 149.0 149.0 148.0 149.0 149.0 149.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 10:48:15 INFO - PROCESS | 10794 | Values: 95.0 95.0 95.0 96.0 98.0 95.0 96.0 96.0 95.0 95.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 10:48:15 INFO - PROCESS | 10794 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 66.0 67.0 66.0 65.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.22 10:48:15 INFO - PROCESS | 10794 | Values: 69.0 67.0 66.0 67.0 69.0 67.0 70.0 68.0 68.0 67.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:85.50 stddev:3.33 (3.9%) stddev-sans-first:3.54 10:48:15 INFO - PROCESS | 10794 | Values: 86.0 84.0 88.0 85.0 95.0 87.0 85.0 85.0 84.0 84.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:146.00 stddev:13.17 (9.0%) stddev-sans-first:13.94 10:48:15 INFO - PROCESS | 10794 | Values: 147.0 146.0 146.0 141.0 137.0 132.0 143.0 133.0 179.0 146.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:177.00 stddev:2.37 (1.3%) stddev-sans-first:2.51 10:48:15 INFO - PROCESS | 10794 | Values: 176.0 178.0 175.0 176.0 178.0 175.0 180.0 172.0 179.0 175.0 10:48:15 INFO - PROCESS | 10794 | 10:48:15 INFO - PROCESS | 10794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.50 stddev:3.01 (4.4%) stddev-sans-first:3.16 10:48:15 INFO - PROCESS | 10794 | Values: 68.0 71.0 69.0 68.0 68.0 69.0 68.0 68.0 77.0 66.0 10:48:15 INFO - PROCESS | 10794 | -------- Summary: end -------- 10:48:15 INFO - PROCESS | 10794 | 10:48:16 INFO - TEST-INFO | 10794: exit 0 10:48:16 INFO - TEST-OK | kraken | took 64186ms 10:48:16 INFO - SUITE-END | took 1186s 10:48:17 INFO - Completed test suite (00:19:46) 10:48:17 INFO - javascript benchmark 10:48:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.922692319231, 2585.5087533368664, 2613.046238123085, 2630.7237740037294, 2637.314298282446, 4738.45507766607, 4796.3045358423005, 4799.592034677048, 4805.207140821764, 4830.686005409655, 4849.466558678551, 4853.344798452208, 4862.513748625136, 4917.139500587392, 4968.652194346397, 4382.846600368987, 4412.139632771595, 4453.042595841894, 4506.188886000518, 4529.841455549056, 4099.73351732138, 4517.367568540407, 4547.386102876102, 4579.404677391951, 4629.1436084324505, 4518.887027824298, 4520.886977825548, 4553.954460455386, 4556.430446194226, 4590.632749380042, 4352.281873490871, 4394.538573449806, 4402.075564131536, 4444.488883778375, 4446.088551846864, 4414.161309351213, 4416.690831641787, 4419.049904270597, 4422.6682998774895, 4427.977860110711, 4829.1307564638355, 4855.830045948375, 4884.7069175849565, 4930.161872481687, 4930.704157750511, 5236.266922630834, 5242.318498595197, 5242.318498595197, 5242.895142097137, 5290.470952904717, 5066.341375621146, 5270.156774915995, 5273.920891186635, 5278.762455689503, 5281.815136470205, 4763.857084287477, 4845.248986407112, 4869.537393947569, 4880.585150262196, 4931.3835770528685, 5270.868228294246, 5302.416734159239, 5304.098303288451, 5318.65428747138, 5383.703896285742, 5104.259882317117, 5138.743062846843, 5143.819966301162, 5151.742412879416, 5190.11767999441, 5085.084684756779, 5086.491350864884, 5086.92369614456, 5185.688858668492, 5190.299309593157, 5010.098182327216, 5099.898002040012, 5146.665466744649, 5148.742562871917, 5151.278820965068, 5068.265101560327, 5117.488251174927, 5126.154184559506, 5168.870778230499, 5176.042432150064, 4376.9124617508105, 4383.276759334738, 4383.49589797171, 4384.232759267179, 4420.889477763018, 3698.2973235085246, 3802.2015376770637, 3811.5807261201244, 3833.7124715646437, 3834.041489627593, 4376.146651402946, 4451.6883818133065, 4483.3723278741, 4484.282514797616, 4501.392312037833, 5216.478352164753, 5222.216667499905, 5223.582113430916, 5226.268322434862, 5270.657407268592, 4328.805203765838, 4439.467263928284, 4482.238019536687, 4487.304467807495, 4493.550644935545, 4518.525554816697, 4637.744924029211, 4673.532646735299, 4680.648951328664, 4722.24444088951, 4828.830990915301, 4837.467878533429, 4838.903221935612, 4843.733594652328, 4882.90234195307, 5247.396549396868, 5249.2651028855225, 5249.7112658804135, 5255.684658920477, 5261.3686357637325, 4639.884002899955, 4696.624270058455, 4707.693999889996, 4713.811447542197, 4741.83403580873, 5056.469070747518, 5060.367454068241, 5064.7467626619255, 5068.189089745623, 5121.180611102206, 5128.282040514257, 5135.127028405105, 5146.665466744649, 5175.560077393464, 5195.584353251656, 5026.52248036436, 5074.543291103819, 5077.796888124433, 5081.92377114351, 5151.7166555839785, 5085.923711144262, 5094.388673359221, 5094.974525127351, 5098.388193416814, 5150.40770311419, 4887.535684110004, 5003.974980125076, 5008.724520151427, 5012.77442515095, 5015.899682006267, 5014.774335154853, 5044.4198917125, 5045.369328833895, 5047.394312682355, 5048.116579598629, 4918.754062296943, 4973.278874563096, 4976.477469865612, 4976.651634385558, 4980.576650984707], "value": 4747.88005644478, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.6395759011102, 522.1984254169847, 528.0152515558482, 538.0, 551.7930775959015, 28807.71192288079, 38050.23899522011, 39521.4071788923, 39983.60016399835, 43792.0, 41224.38163427551, 41681.58318416815, 41694.791526042405, 41822.37266441006, 41847.0, 7534.8116297092465, 7637.961810190941, 7794.688212471494, 7801.843963120763, 7806.258405451473, 7514.549127052367, 9878.753031174207, 10134.89865101347, 10139.543720532594, 10432.530536125854, 9811.313208075437, 9863.26025548083, 9870.901290987105, 9878.802423951516, 9884.308098433112, 9777.217822574212, 9828.410295382228, 9830.852537211947, 9837.213022958182, 9849.704508864745, 9887.653932112342, 9970.15253703436, 9971.650992215238, 9974.551145198484, 9979.501024948797, 37675.24649506994, 37873.43189852154, 38033.0, 38058.23883522342, 38166.23667526634, 3677.669009789105, 3760.793156376398, 3772.396416573335, 3808.619138086169, 3823.235352929425, 28572.285692857637, 28732.569011464635, 28875.855620721763, 29866.954656586917, 29972.8501357494, 3033.8331391773445, 3041.102874651961, 3083.5683004379407, 3090.3819236152635, 3169.9683003170135, 223473.0, 226039.8698006516, 226862.0, 226877.0, 227719.0, 52602.473975260524, 52946.47053529415, 53115.0, 53125.0, 53156.20265696017, 55218.0, 55221.72389138109, 55376.723116384965, 55419.722901385234, 55420.16869746957, 14036.0, 14622.195779232245, 14644.487442939446, 14646.194459304628, 14649.560513184622, 9454.33819632633, 9717.56270967794, 10608.20438467118, 10694.679159625224, 11212.27120237182, 16180.271887765079, 16303.347866085462, 16336.0, 16360.918195409186, 16386.344546218257, 6384.58500197495, 6564.540482166202, 6570.8357291068105, 6592.736290548324, 6667.63328016954, 772.9729459468891, 778.4823092643329, 791.6358475101517, 804.4851295171095, 805.8509175802495, 27069.86465067662, 27647.3198924863, 27698.5845212322, 28036.43927121446, 28279.29301767472, 921.5806807902522, 922.5663937949154, 935.0976307862945, 938.0572524612857, 949.0888746803147, 14532.636684082983, 14830.258487075604, 14941.0, 15119.244037798066, 15178.848211517965, 312886.0, 346803.0, 354538.0, 354673.0, 513478.0, 43762.34356484655, 44055.77972110183, 44137.558624413985, 44183.55816441859, 44204.77897610491, 1190.0836356006, 1210.9031277497954, 1219.8902098810972, 1222.10175520992, 1222.4560070768423, 24387.14644987417, 25057.373565661004, 25167.0, 26029.739702602732, 26065.478690425705, 36248.81875590605, 36606.267874642894, 36681.0, 36731.44902826406, 36770.632293677794, 281187.0, 282276.0, 282953.0, 283171.0, 283278.0, 20877.0, 21581.35255942324, 22180.0, 22907.0, 23197.76802231956, 35666.46500302549, 35673.28653426969, 35784.642153578134, 36105.277894442486, 36254.4561831578, 29350.559741603465, 30092.699073009866, 30629.0, 31134.22164445907, 31841.203969900936, 28716.282092947844, 28907.855460722563, 29108.854455727585, 29276.80423968168, 30299.24251893632, 30619.387612247185, 30763.538546921365, 30816.383672326876, 30978.225544361572, 31149.532757009118, 25785.484290314464, 27154.592681109403, 27991.860040699667, 28137.0, 28221.0, 21637.891810540845, 21905.233316833834, 22076.116955321606, 22145.0, 22151.224707135174], "value": 16947.81439572167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.57580327803356, 360.70962874885726, 371.8159511042034, 372.1997704934391, 385.66061865558305, 12797.936010319958, 13661.795073073912, 14104.294785260734, 16503.33986640533, 17144.14279286037, 15002.549923502313, 15353.462628807994, 15402.537923862274, 15919.522414327559, 16379.344826206967, 4292.401800714904, 4585.9541404586025, 4653.9069218615605, 4678.111158879819, 4684.601808846252, 4528.615067719248, 4612.492625811158, 4617.676762626617, 4619.376384188142, 4619.74591397473, 3624.528811254533, 3774.8301326440237, 5183.740812959356, 5379.596530260226, 5399.892002159954, 5297.496737809902, 5473.31583552056, 5480.671159730429, 5480.890382192354, 5484.341878974548, 5198.2202669599865, 5250.947490525123, 5256.9737151314, 5260.789568417259, 5264.473552644705, 12072.336021518813, 12134.757304853854, 12523.373831308489, 19739.309124180585, 19875.90062049695, 2154.4721543221854, 2170.338046895696, 2186.650135978236, 2404.483036147237, 2455.70531536215, 8709.172628600272, 8907.376483646147, 9026.368154229207, 9427.48148851813, 9490.857637135448, 1643.909584972826, 1676.639522502668, 1693.8390852868959, 1712.9828701713072, 1763.9647207055787, 41142.588574114474, 61522.0771688425, 62298.68850655763, 62602.37397626056, 63967.0, 9621.422714637145, 9760.219182465386, 9885.802283954281, 9918.553665085088, 10107.797844043078, 13158.894576867846, 13186.604401867959, 13194.274314912773, 13196.47214111444, 13211.207327560378, 7186.6047367395295, 7218.927810721931, 7314.08573928259, 7478.214787447239, 7515.060617422822, 6932.826679332956, 6975.0, 6998.93001069993, 7139.321764432474, 7142.250063743336, 4315.705288413464, 4341.674374421931, 4353.564643535621, 4363.36731173978, 4438.977805111019, 1805.2237537858584, 1843.262694922015, 1855.4526414707693, 1862.7299041639158, 1871.2889102141098, 830.767385132164, 844.2697067036969, 862.2067697718114, 867.5402036920442, 883.5449743382163, 13316.800247996287, 13374.0, 13391.0, 13441.39513721885, 13486.730265394834, 828.5774255129927, 840.6469282901074, 842.3177226446597, 848.9490630562186, 859.6260626627437, 7372.557646541225, 7374.225706300868, 7407.333339999426, 7408.0, 7437.0331856858265, 321347.0, 323758.8617024432, 329109.0, 329998.0, 330224.0, 50195.74902125539, 50968.74515627398, 68418.65790671014, 68959.31040689629, 70867.0, 872.7687162901836, 890.6303883888244, 909.0318810466831, 911.166282851197, 913.3332667153015, 11960.58137965167, 11974.161808673309, 12094.334811585448, 12329.50681972711, 12401.193922395016, 32922.67077329196, 33253.0, 33528.832355838065, 33655.14896680706, 34441.655583444845, 44003.77998109989, 45288.32067518924, 46591.534084660074, 47036.0, 49895.0, 6744.0558321834005, 6807.863842723217, 6901.275366086689, 7036.753713620204, 7218.422526197996, 10116.89883101189, 11421.257618254787, 11477.253978491372, 11722.648320550397, 12110.0, 9995.500224988577, 10250.411186266141, 10326.690199294033, 10391.064804167661, 10780.245382823126, 10225.590976360862, 10345.551622772668, 10463.738406539593, 10494.370337779757, 10523.894761052292, 10309.587616495557, 10367.948160259451, 10380.532876020447, 10479.528421220912, 10629.149668026694, 6785.525013249223, 6911.654417279216, 6952.721891124298, 6962.617056061965, 7321.121465424183, 8149.877751833608, 9641.951790241004, 9798.461084640414, 9832.852507212254, 10102.949485252526], "value": 7632.929825828089, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.8297221361222, 1324.960251192464, 1330.2151730479015, 1331.7536255792686, 1347.2657401716065, 6848.349406806352, 7261.927380726192, 7264.309890560401, 7269.236730143338, 7304.0, 6400.199975003125, 6598.769043083493, 6919.100516932792, 7061.187963384213, 7071.85856282874, 2044.7546294444687, 2072.3264938894918, 2074.9273775417864, 2074.968875466862, 2078.0752565108533, 2074.553970896257, 2114.3762590035976, 2116.608427440921, 2127.287358734826, 2130.084063852543, 1788.445581869618, 1851.9259229630798, 1980.3167907072109, 2060.6702927531596, 2068.7103805467245, 2052.189385192848, 2091.4562213824365, 2091.592139532792, 2096.224396973122, 2096.4863608416035, 2071.18188315616, 2079.1371580793952, 2090.7595626502994, 2099.9160033598637, 2108.1778106538463, 7152.213256541776, 7189.245129261404, 7207.5675459472595, 7214.603196824172, 7219.927800721978, 4223.239816832969, 4340.60934515895, 4343.717658352229, 4348.543402942677, 4352.934705979413, 2698.7031426543263, 2816.0847724489417, 2816.310004049001, 2829.3351062500296, 2832.065418411919, 1043.519980808829, 1060.872695276564, 1090.967270981864, 1098.8681358236984, 1117.6032508459461, 9360.531973401303, 9559.952200239093, 9613.279004074722, 9625.278104142217, 9626.518674066268, 3953.0512676957323, 3955.5759926426463, 3964.682825373963, 3969.364901615728, 4031.7177797554477, 8352.081271060179, 8355.582220888931, 8356.206160414751, 8358.540280284522, 8362.874556881652, 4384.539623339567, 4386.495553011381, 4387.14450682114, 4389.012472193731, 4389.209942210433, 3896.902577435587, 3934.8426062957733, 3938.212357528506, 3958.4062390641056, 3960.6237407446247, 3253.674632536775, 3328.2012317043736, 3374.088995971074, 3392.8982130536124, 3467.081223475781, 1026.8459731040405, 1042.4839704346398, 1062.2829590026702, 1064.41989115932, 1068.0, 634.4924060751381, 636.2619361540683, 640.3500447046159, 662.5130529061137, 685.9108315918899, 4436.157130145262, 4499.942513509322, 4596.632269418438, 4636.423615970519, 4735.384400028043, 513.1968469345462, 514.675754274812, 514.7503460821498, 516.2411255454476, 639.2169592249458, 2903.3612605226817, 2921.0944607171846, 3038.483457812177, 3101.379724055153, 3174.904752857418, 7908.52548847071, 7983.72056978003, 8322.8335433291, 8339.291160251447, 8353.707620233263, 8504.829903402022, 8509.446885952393, 8511.914880851113, 8514.403991720521, 8517.105703901001, 6604.5046621502615, 6746.763863264664, 6772.661366931634, 6774.254831968479, 6783.050372947791, 4683.391159149289, 4685.226937555265, 4695.342652028787, 4796.688215265996, 4799.736014519235, 7892.723754668559, 7929.920700792918, 7955.721549745731, 7956.681732730626, 8018.398620103399, 7878.369730421437, 8030.5181689098845, 8031.959840200761, 8192.0, 8196.918030819854, 6103.05402662588, 6217.96891015542, 6220.03589443637, 6221.440070393686, 6222.81331560054, 6852.931470685428, 6883.896741548981, 6901.1718593769065, 6917.481188910751, 6927.792166235021, 6241.188645476059, 6259.906101408392, 6264.937350626617, 6294.8111556653375, 6393.520485963479, 6053.364396738279, 6103.267607887082, 6119.204503414528, 6131.570790044832, 6231.4391704746795, 5402.621816472809, 5531.861703457445, 5570.0, 5576.498115169492, 5647.378788333198, 4050.6556942660204, 4124.608162224584, 4125.752454852718, 4197.370394440858, 4297.76362300064, 4139.689523285705, 4239.173361194537, 4298.656107511329, 4342.739435633872, 4411.426514553087], "value": 3758.5925355939903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.6526191177867, 350.95546137259277, 352.80771979271293, 357.12326239083035, 359.57031347539686, 4926.0, 4935.77788999495, 4947.406311242651, 4960.305557221992, 4979.626528010395, 4850.296706977495, 4864.537868902457, 4866.805327786884, 4878.4389795173565, 4897.853064408065, 3441.5698037745283, 3688.409854423293, 3809.3333666608232, 3895.6493915547594, 3950.9604903950953, 3887.261420330128, 3890.396988466792, 3906.980465097685, 3909.5534652178735, 3912.647861692447, 3878.747881387715, 3890.319194141028, 3892.1048158923463, 3892.746971446861, 3896.5324161100707, 3720.274546463441, 3817.141143242776, 3820.656140947328, 3903.668188203992, 3911.9022024449473, 3492.0, 3493.7030352420074, 3502.176988407722, 3504.4392897136336, 3514.2268700885766, 4714.57568818808, 4720.0, 4723.315119307716, 4732.905341893177, 4783.4977327380475, 4345.804903651489, 4467.396901418332, 4474.149911516802, 4474.38248624555, 4477.3731677565165, 5029.918567507967, 5041.546260836506, 5057.620678449131, 5070.315507406527, 5101.393061185715, 3791.0, 3799.126200973764, 3809.904752381185, 3848.6536211741077, 3869.7484663496784, 5072.9746351268, 5244.187150991603, 5347.422510359454, 5351.892962140774, 5352.652077614943, 3831.0, 3920.666743326792, 3937.940930886039, 3951.920961580752, 3961.9009524761536, 3979.900502487461, 3985.4855155041478, 3985.6811455083525, 3994.3409337459575, 4015.554400415848, 4454.910901781946, 4458.684688017042, 4466.352378905106, 4473.731576105444, 4489.506154323022, 4944.53026962438, 5089.9745501273, 5111.616628752859, 5111.821086262037, 5133.794648214104, 1333.9061969185368, 1342.9597112086653, 1343.234356416833, 1351.6283022168982, 1360.4490181476517, 910.4082346474712, 933.9252859771202, 939.9013103624021, 940.9884374297658, 981.5435822342645, 4332.415123958225, 4333.198358303661, 4337.0024894273865, 4346.413234213404, 4354.629856462237, 4961.975190124099, 4964.659541923733, 4994.875128121754, 5019.949800502021, 5035.3131700879885, 4301.225779359683, 4318.222719910384, 4318.546552611931, 4323.69734118615, 4333.674974376934, 2557.693076830792, 2700.2169370882225, 2715.823471474348, 2719.619253304539, 2721.6461859958476, 4685.718856868599, 4712.24604063355, 4724.480307166209, 4728.40894888139, 4780.856574302707, 5056.949430505648, 5235.188545775411, 5254.500822421864, 5270.8155214567305, 5271.868203294948, 4841.467438581753, 4859.538343857328, 4880.804767809319, 4881.365422495053, 4888.364512613338, 5269.446708095595, 5291.0, 5295.338082739658, 5321.3880403754065, 5329.307190065267, 4967.850964471072, 5241.868953276046, 5244.292020577326, 5260.237265596544, 5266.552343050884, 4634.884127896829, 4765.475797662324, 4781.784819683053, 4867.853964381075, 4893.412790465167, 3892.8832135035996, 3936.8031598419393, 3944.4674968878835, 3956.7032472565247, 3964.306246406925, 5255.7123504741585, 5287.233351163983, 5295.099833028317, 5300.416954135119, 5313.654612450178, 4922.310876477224, 5045.445001049955, 5085.194491205775, 5157.303763991963, 5166.767495462788, 5013.172826483736, 5048.798048078036, 5052.469490703424, 5058.140116180185, 5063.594912406925, 4989.525995030466, 5008.347245409079, 5017.147084995487, 5020.196768517019, 5063.721495317793, 4887.36464259644, 5108.642395032312, 5118.539331460038, 5128.256402821645, 5160.251763494347, 5001.349824522788, 5003.524665156804, 5004.249362595494, 5014.197728363444, 5015.548600625962], "value": 3889.1586158941045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.4296797334358, 680.9182898052235, 731.9268073192682, 749.4454103963067, 754.675489539498, 11907.345096019726, 12469.438875250613, 12595.811062834042, 12645.873541264596, 12808.423620937057, 13447.058705890568, 13673.794893076612, 13728.931355343235, 13731.17612943224, 13734.17594944304, 661.4113439039235, 685.9588424694509, 796.2157275084038, 812.6708682983401, 829.3655353654459, 815.4169768615438, 832.8958880139983, 833.1793183714037, 833.5832083958021, 833.7165363776345, 885.2431171348501, 888.4491615198554, 889.0, 889.1641856654757, 890.0921060518267, 705.1855107351017, 728.9416846652255, 842.2630198576246, 885.6767279942839, 886.4326830828243, 639.0414378432351, 644.6937704590329, 644.935506449356, 645.1741770533724, 645.6739346629969, 13143.408546615425, 13152.0, 13196.0, 13243.271620060892, 13258.337083145803, 12906.677333066655, 12907.999999999905, 12918.483260669562, 12920.0, 13076.738465230643, 11727.7068073298, 11729.941350293278, 11799.233049851731, 11869.10981676369, 11888.643340699793, 3937.8424863005444, 3962.821673024721, 3987.2623564640635, 4057.3913912913004, 4111.259973204822, 60413.395866041654, 60464.0, 60519.394806051816, 60573.39426605766, 61081.389186108456, 9851.261155413373, 10064.798704025878, 10352.120069794151, 10420.68737937863, 10619.097376723064, 19585.314513991943, 19679.704804427944, 19759.308424205083, 19910.800891991184, 19969.500762481053, 6561.80314590563, 6563.50773691975, 6627.072209890619, 6630.900536491957, 6715.731370745213, 3499.61504234534, 3559.750817442754, 3577.982110089485, 3581.982090089533, 3692.1692619160476, 2767.764739997123, 2829.2643912582876, 2833.447477741862, 3141.9214519637194, 3284.540164376989, 565.2877374508149, 566.6260268223035, 566.8412844403574, 569.7749388991325, 579.8289504596154, 582.8018473718871, 599.1103211730576, 602.6866029664637, 604.3291945940003, 611.4191518057863, 7741.109772376249, 7940.09437734951, 8066.556339401389, 8078.838423231502, 8101.149379315205, 484.12373603777274, 485.6964397251718, 491.49867135521566, 498.7905079866465, 504.55599072815687, 3758.8684396046006, 3937.27160475313, 4041.0907545802547, 4059.109984955292, 4071.918561628751, 62809.68595156995, 63929.68035159794, 64513.0, 65116.34883651198, 66715.0, 52306.0, 54294.0, 55117.0, 55454.445455545734, 55598.16602750962, 50580.494195058316, 50913.23630145477, 51288.0, 51478.74260628673, 51918.48081519137, 7529.247075292427, 7675.808104797425, 7732.729354472566, 7858.410619203697, 8019.6391162398995, 34330.82834585811, 34800.30399391947, 35689.82155089208, 36034.819825900704, 36149.457758133125, 35358.0, 43651.56348436602, 44406.55593444024, 44527.87553991346, 45573.54426455826, 9153.725388238363, 9321.580528876082, 9403.670871519464, 9511.619535218513, 9878.506074696093, 10570.10154136907, 10723.892761072602, 10732.570697172338, 11328.150388720715, 11508.136889733136, 10547.156227501935, 10911.945440272748, 10921.672349829518, 11227.7754444909, 11246.550137994389, 10159.339642923187, 10325.845112323172, 10380.584776608852, 10456.372617642966, 10729.088027517748, 10218.846717299395, 10314.845277320695, 10397.0, 10646.307989980627, 10807.891921081004, 8652.307815374881, 8693.652253909773, 8775.956120219358, 8871.955640221757, 9166.312526560401, 8368.113626099743, 8532.488050716976, 8534.70128545498, 8599.14008599135, 8720.43317184381], "value": 6160.106300112572, "unit": "score"}], "name": "dromaeo_css", "value": 6172.634482634409, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 117.0, 115.0, 116.0, 116.0, 115.0, 116.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 128.0, 180.0, 130.0, 129.0, 138.0, 127.0, 146.0, 131.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 163.0, 162.0, 163.0, 162.0, 163.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 113.0, 78.0, 78.0, 78.0, 77.0, 92.0, 79.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 114.0, 86.0, 84.0, 86.0, 100.0, 85.0, 85.0, 108.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 148.0, 149.0, 149.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 98.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 67.0, 66.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 67.0, 69.0, 67.0, 70.0, 68.0, 68.0, 67.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 88.0, 85.0, 95.0, 87.0, 85.0, 85.0, 84.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 141.0, 137.0, 132.0, 143.0, 133.0, 179.0, 146.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 175.0, 176.0, 178.0, 175.0, 180.0, 172.0, 179.0, 175.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 77.0, 66.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1562.1000000000001, "alertThreshold": 2.0}]} 10:48:17 INFO - Return code: 0 10:48:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:48:17 INFO - # TBPL SUCCESS # 10:48:17 INFO - Running post-action listener: _resource_record_post_action 10:48:17 INFO - [mozharness: 2016-12-30 18:48:17.399586Z] Finished run-tests step (success) 10:48:17 INFO - Running post-run listener: _resource_record_post_run 10:48:17 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394686464; Read time: 16; Write time: 333792 10:48:17 INFO - TinderboxPrint: CPU usage
13.1% 10:48:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:48:17 INFO - TinderboxPrint: I/O write bytes / time
394,686,464 / 333,792 10:48:17 INFO - TinderboxPrint: CPU idle
8,344.8 (86.9%) 10:48:17 INFO - TinderboxPrint: CPU user
1,211.4 (12.6%) 10:48:17 INFO - TinderboxPrint: Swap in / out
0 / 0 10:48:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99905536; Read time: 0; Write time: 84828 10:48:17 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 294780928; Read time: 0; Write time: 248964 10:48:18 INFO - Running post-run listener: _upload_blobber_files 10:48:18 INFO - Blob upload gear active. 10:48:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:48:18 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 10:48:18 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:48:18 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:48:18 INFO - (blobuploader) - INFO - Open directory for files ... 10:48:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:48:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:48:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:19 INFO - (blobuploader) - INFO - Done attempting. 10:48:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:48:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:48:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:22 INFO - (blobuploader) - INFO - Done attempting. 10:48:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:48:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:48:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:23 INFO - (blobuploader) - INFO - Done attempting. 10:48:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:48:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:48:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:24 INFO - (blobuploader) - INFO - Done attempting. 10:48:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:48:24 INFO - Return code: 0 10:48:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:48:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:48:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c63b743dd72905153467e038a3b085f347b86cc8cdb2c91bb1867a46d704b0d46ed6cf1b9b0fd81910944b2ac158d22a2b5901ab15122f4c2244c85e615a772f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0a8813ce3b03bf12f94a3932d12ea1b86d41faf0300423d88493ed0baa8b102a7f9b141413bca3cbe00f7211b94f6ac7447c482bcb2ebf2b44252cba10943f6f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0ea1a8cad271a9ae129278e6c9e002058d46a46eb4afff70adfa5582eb6d17b6441391408a6076aaf7579ae6b37fb34025f6700af7f8061ec9ada33c1dc17e5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/478d97a82ad02f1b209771c356eefae7081e14dfaef94036d6d52b0b004ff39722c396bbd12de6ff01481f94337912d8634a3706e86ae1e61b83f39f976d6758"} 10:48:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:48:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:48:24 INFO - Contents: 10:48:24 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c63b743dd72905153467e038a3b085f347b86cc8cdb2c91bb1867a46d704b0d46ed6cf1b9b0fd81910944b2ac158d22a2b5901ab15122f4c2244c85e615a772f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0a8813ce3b03bf12f94a3932d12ea1b86d41faf0300423d88493ed0baa8b102a7f9b141413bca3cbe00f7211b94f6ac7447c482bcb2ebf2b44252cba10943f6f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0ea1a8cad271a9ae129278e6c9e002058d46a46eb4afff70adfa5582eb6d17b6441391408a6076aaf7579ae6b37fb34025f6700af7f8061ec9ada33c1dc17e5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/478d97a82ad02f1b209771c356eefae7081e14dfaef94036d6d52b0b004ff39722c396bbd12de6ff01481f94337912d8634a3706e86ae1e61b83f39f976d6758"} 10:48:24 INFO - Running post-run listener: copy_logs_to_upload_dir 10:48:24 INFO - Copying logs to upload dir... 10:48:24 INFO - mkdir: /builds/slave/test/build/upload/logs 10:48:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.013190 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-12-30 10:48:23.960359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 10:48:23.964007) ========= 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=d2a8c569965ab8367867b893000001a1-1483120912.576580-606264268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c63b743dd72905153467e038a3b085f347b86cc8cdb2c91bb1867a46d704b0d46ed6cf1b9b0fd81910944b2ac158d22a2b5901ab15122f4c2244c85e615a772f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0a8813ce3b03bf12f94a3932d12ea1b86d41faf0300423d88493ed0baa8b102a7f9b141413bca3cbe00f7211b94f6ac7447c482bcb2ebf2b44252cba10943f6f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0ea1a8cad271a9ae129278e6c9e002058d46a46eb4afff70adfa5582eb6d17b6441391408a6076aaf7579ae6b37fb34025f6700af7f8061ec9ada33c1dc17e5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/478d97a82ad02f1b209771c356eefae7081e14dfaef94036d6d52b0b004ff39722c396bbd12de6ff01481f94337912d8634a3706e86ae1e61b83f39f976d6758"} build_url:https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/bQKw5tDeRKWWVTgCX90Rog/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c63b743dd72905153467e038a3b085f347b86cc8cdb2c91bb1867a46d704b0d46ed6cf1b9b0fd81910944b2ac158d22a2b5901ab15122f4c2244c85e615a772f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0a8813ce3b03bf12f94a3932d12ea1b86d41faf0300423d88493ed0baa8b102a7f9b141413bca3cbe00f7211b94f6ac7447c482bcb2ebf2b44252cba10943f6f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0ea1a8cad271a9ae129278e6c9e002058d46a46eb4afff70adfa5582eb6d17b6441391408a6076aaf7579ae6b37fb34025f6700af7f8061ec9ada33c1dc17e5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/478d97a82ad02f1b209771c356eefae7081e14dfaef94036d6d52b0b004ff39722c396bbd12de6ff01481f94337912d8634a3706e86ae1e61b83f39f976d6758"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 10:48:23.989433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 10:48:23.989796) ========= 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=d2a8c569965ab8367867b893000001a1-1483120912.576580-606264268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 10:48:24.072241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 10:48:24.072565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 10:48:24.072850) ========= ========= Total master_lag: 0.17 =========