builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1481384037.46 results: success (0) buildid: 20161210063617 builduid: cd2d573b9bab410380505a1063b3706b revision: 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:57.455528) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:57.455990) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:57.456267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:57.471347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:57.471819) ========= 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=1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-10 07:33:57-- 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% 87.9M=0s 2016-12-10 07:33:58 (87.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124699 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:57.689298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:57.689620) ========= 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=1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022063 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:57.726131) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:57.726438) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b --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=1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-10 07:33:58,188 truncating revision to first 12 chars 2016-12-10 07:33:58,188 Setting DEBUG logging. 2016-12-10 07:33:58,188 attempt 1/10 2016-12-10 07:33:58,188 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/97c0626d8789?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-10 07:33:58,533 unpacking tar archive at: mozilla-central-97c0626d8789/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:58.460202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:58.460503) ========= script_repo_revision: 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:58.460906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:58.461183) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-10 07:33:58.469653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-10 07:33:58.470025) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:33:59 INFO - MultiFileLogger online at 20161210 07:33:59 in /builds/slave/test 07:33:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:33:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:33:59 INFO - {'append_to_log': False, 07:33:59 INFO - 'base_work_dir': '/builds/slave/test', 07:33:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:33:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:33:59 INFO - 'branch': 'Firefox-Non-PGO', 07:33:59 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:59 INFO - 'config_files': ('talos/linux_config.py',), 07:33:59 INFO - 'default_actions': ('clobber', 07:33:59 INFO - 'read-buildbot-config', 07:33:59 INFO - 'download-and-extract', 07:33:59 INFO - 'populate-webroot', 07:33:59 INFO - 'create-virtualenv', 07:33:59 INFO - 'install', 07:33:59 INFO - 'run-tests'), 07:33:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:59 INFO - 'download_minidump_stackwalk': True, 07:33:59 INFO - 'download_symbols': 'ondemand', 07:33:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:33:59 INFO - 'tooltool.py': '/tools/tooltool.py', 07:33:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:33:59 INFO - '/tools/misc-python/virtualenv.py')}, 07:33:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:59 INFO - 'installer_path': 'installer.exe', 07:33:59 INFO - 'log_level': 'info', 07:33:59 INFO - 'log_name': 'talos', 07:33:59 INFO - 'log_to_console': True, 07:33:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:33:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:33:59 INFO - 'opt_config_files': (), 07:33:59 INFO - 'pip_index': False, 07:33:59 INFO - 'sps_profile': False, 07:33:59 INFO - 'sps_profile_interval': 0, 07:33:59 INFO - 'suite': 'dromaeojs', 07:33:59 INFO - 'system_bits': '32', 07:33:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:59 INFO - 'title': 'talos-linux64-ix-027', 07:33:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:33:59 INFO - 'use_talos_json': True, 07:33:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:33:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:59 INFO - 'work_dir': 'build'} 07:33:59 INFO - [mozharness: 2016-12-10 15:33:59.024051Z] Running clobber step. 07:33:59 INFO - Running pre-action listener: _resource_record_pre_action 07:33:59 INFO - Running main action method: clobber 07:33:59 INFO - rmtree: /builds/slave/test/build 07:33:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:33:59 INFO - Running post-action listener: _resource_record_post_action 07:33:59 INFO - [mozharness: 2016-12-10 15:33:59.483606Z] Finished clobber step (success) 07:33:59 INFO - [mozharness: 2016-12-10 15:33:59.483717Z] Running read-buildbot-config step. 07:33:59 INFO - Running pre-action listener: _resource_record_pre_action 07:33:59 INFO - Running main action method: read_buildbot_config 07:33:59 INFO - Using buildbot properties: 07:33:59 INFO - { 07:33:59 INFO - "project": "", 07:33:59 INFO - "product": "firefox", 07:33:59 INFO - "script_repo_revision": "production", 07:33:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:33:59 INFO - "repository": "", 07:33:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:33:59 INFO - "buildid": "20161210063617", 07:33:59 INFO - "pgo_build": "False", 07:33:59 INFO - "basedir": "/builds/slave/test", 07:33:59 INFO - "buildnumber": 334, 07:33:59 INFO - "slavename": "talos-linux64-ix-027", 07:33:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:33:59 INFO - "platform": "ubuntu64_hw", 07:33:59 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:33:59 INFO - "branch": "mozilla-central", 07:33:59 INFO - "repo_path": "mozilla-central", 07:33:59 INFO - "revision": "97c0626d8789b7bcaaa04e4661bf36f58f3fb82b", 07:33:59 INFO - "stage_platform": "linux64", 07:33:59 INFO - "builduid": "cd2d573b9bab410380505a1063b3706b", 07:33:59 INFO - "slavebuilddir": "test" 07:33:59 INFO - } 07:33:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:33:59 INFO - Running post-action listener: _resource_record_post_action 07:33:59 INFO - [mozharness: 2016-12-10 15:33:59.486235Z] Finished read-buildbot-config step (success) 07:33:59 INFO - [mozharness: 2016-12-10 15:33:59.486321Z] Running download-and-extract step. 07:33:59 INFO - Running pre-action listener: _resource_record_pre_action 07:33:59 INFO - Running main action method: download_and_extract 07:33:59 INFO - mkdir: /builds/slave/test/build/tests 07:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:59 INFO - trying https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:33:59 INFO - Downloading https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/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 07:33:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/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 07:34:00 INFO - Downloaded 1361 bytes. 07:34:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:34:00 INFO - Using the following test package requirements: 07:34:00 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:34:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:34:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:34:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:00 INFO - u'jsshell-linux-x86_64.zip'], 07:34:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:34:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:34:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:34:00 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:34:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:34:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:34:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:34:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:34:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:34:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:34:00 INFO - Fetch https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:34:00 INFO - Expected file size: 20222410 07:34:00 INFO - Obtained file size: 20222410 07:34:04 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 07:34:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:34:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:34:04 INFO - Fetch https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:34:05 INFO - Expected file size: 20222410 07:34:05 INFO - Obtained file size: 20222410 07:34:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:34:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:34:10 INFO - Fetch https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:34:10 INFO - Expected file size: 14409734 07:34:10 INFO - Obtained file size: 14409734 07:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:11 INFO - trying https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:34:11 INFO - Downloading https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/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 07:34:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/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 07:34:12 INFO - Downloaded 55768082 bytes. 07:34:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:34:12 INFO - mkdir: /builds/slave/test/properties 07:34:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:12 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:12 INFO - Contents: 07:34:12 INFO - build_url:https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:34:13 INFO - Running post-action listener: _resource_record_post_action 07:34:13 INFO - Running post-action listener: set_extra_try_arguments 07:34:13 INFO - [mozharness: 2016-12-10 15:34:13.068788Z] Finished download-and-extract step (success) 07:34:13 INFO - [mozharness: 2016-12-10 15:34:13.069113Z] Running populate-webroot step. 07:34:13 INFO - Running pre-action listener: _resource_record_pre_action 07:34:13 INFO - Running main action method: populate_webroot 07:34:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:13 INFO - '--tppagecycles', 07:34:13 INFO - '7'], 07:34:13 INFO - 'tests': ['tsvgm']}}, 07:34:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:34:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:34:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:34:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:34:13 INFO - 'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:34:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:34:13 INFO - 'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['damp', 'tps']}, 07:34:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:34:13 INFO - 'tests': ['damp', 'tps']}, 07:34:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['dromaeo_dom']}, 07:34:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['basic_compositor_video']}, 07:34:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:34:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['a11yr', 07:34:13 INFO - 'ts_paint', 07:34:13 INFO - 'tpaint', 07:34:13 INFO - 'sessionrestore', 07:34:13 INFO - 'sessionrestore_no_auto_restore', 07:34:13 INFO - 'tabpaint']}, 07:34:13 INFO - 'other-e10s': {'tests': ['a11yr', 07:34:13 INFO - 'ts_paint', 07:34:13 INFO - 'tpaint', 07:34:13 INFO - 'sessionrestore', 07:34:13 INFO - 'sessionrestore_no_auto_restore', 07:34:13 INFO - 'tabpaint']}, 07:34:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:34:13 INFO - 'ts_paint', 07:34:13 INFO - 'tpaint', 07:34:13 INFO - 'sessionrestore', 07:34:13 INFO - 'sessionrestore_no_auto_restore', 07:34:13 INFO - 'tabpaint']}, 07:34:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:34:13 INFO - 'ts_paint', 07:34:13 INFO - 'tpaint', 07:34:13 INFO - 'sessionrestore', 07:34:13 INFO - 'sessionrestore_no_auto_restore', 07:34:13 INFO - 'tabpaint']}, 07:34:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['a11yr', 07:34:13 INFO - 'ts_paint', 07:34:13 INFO - 'tpaint', 07:34:13 INFO - 'sessionrestore', 07:34:13 INFO - 'sessionrestore_no_auto_restore', 07:34:13 INFO - 'tabpaint']}, 07:34:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['a11yr', 07:34:13 INFO - 'ts_paint', 07:34:13 INFO - 'tpaint', 07:34:13 INFO - 'sessionrestore', 07:34:13 INFO - 'sessionrestore_no_auto_restore', 07:34:13 INFO - 'tabpaint']}, 07:34:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['tsvgx', 07:34:13 INFO - 'tsvgr_opacity', 07:34:13 INFO - 'tart', 07:34:13 INFO - 'tscrollx', 07:34:13 INFO - 'cart', 07:34:13 INFO - 'tsvg_static']}, 07:34:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:34:13 INFO - 'tsvgr_opacity', 07:34:13 INFO - 'tart', 07:34:13 INFO - 'tscrollx', 07:34:13 INFO - 'cart', 07:34:13 INFO - 'tsvg_static']}, 07:34:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:34:13 INFO - 'talos_options': ['--disable-e10s'], 07:34:13 INFO - 'tests': ['tp5o']}, 07:34:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:34:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:34:13 INFO - 'talos_options': ['--disable-e10s', 07:34:13 INFO - '--xperf_path', 07:34:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:13 INFO - 'tests': ['tp5n']}, 07:34:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:34:13 INFO - 'talos_options': ['--xperf_path', 07:34:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:13 INFO - 'tests': ['tp5n']}}, 07:34:13 INFO - 'talos.zip': {'path': '', 07:34:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:13 INFO - Running post-action listener: _resource_record_post_action 07:34:13 INFO - [mozharness: 2016-12-10 15:34:13.091323Z] Finished populate-webroot step (success) 07:34:13 INFO - [mozharness: 2016-12-10 15:34:13.091412Z] Running create-virtualenv step. 07:34:13 INFO - Running pre-action listener: _resource_record_pre_action 07:34:13 INFO - Running main action method: create_virtualenv 07:34:13 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:13 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 07:34:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:13 INFO - Using real prefix '/usr' 07:34:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:34:13 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:15 INFO - Installing pip.................done. 07:34:15 INFO - Return code: 0 07:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:34:15 INFO - Reading from file tmpfile_stdout 07:34:15 INFO - Output received: 07:34:15 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) 07:34:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34:15 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')]} 07:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:15 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')]} 07:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:15 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 0x7f4cbcbd8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, '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': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', '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 07:34:15 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 07:34:15 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 07:34:15 INFO - Using env: {'DISPLAY': ':0', 07:34:15 INFO - 'HOME': '/home/cltbld', 07:34:15 INFO - 'LANG': 'en_US.UTF-8', 07:34:15 INFO - 'LANGUAGE': 'en_US:en', 07:34:15 INFO - 'LOGNAME': 'cltbld', 07:34:15 INFO - 'MAIL': '/var/mail/cltbld', 07:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:15 INFO - 'MOZ_NO_REMOTE': '1', 07:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:15 INFO - 'NO_EM_RESTART': '1', 07:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:15 INFO - 'PWD': '/builds/slave/test', 07:34:15 INFO - 'SHELL': '/bin/bash', 07:34:15 INFO - 'SHLVL': '1', 07:34:15 INFO - 'TERM': 'linux', 07:34:15 INFO - 'TMOUT': '86400', 07:34:15 INFO - 'USER': 'cltbld', 07:34:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:15 INFO - '_': '/tools/buildbot/bin/python'} 07:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:16 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 07:34:16 INFO - Cleaning up... 07:34:16 INFO - Return code: 0 07:34:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:34:16 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')]} 07:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:16 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')]} 07:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:16 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 0x7f4cbcbd8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, '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': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', '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 07:34:16 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 07:34:16 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 07:34:16 INFO - Using env: {'DISPLAY': ':0', 07:34:16 INFO - 'HOME': '/home/cltbld', 07:34:16 INFO - 'LANG': 'en_US.UTF-8', 07:34:16 INFO - 'LANGUAGE': 'en_US:en', 07:34:16 INFO - 'LOGNAME': 'cltbld', 07:34:16 INFO - 'MAIL': '/var/mail/cltbld', 07:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:16 INFO - 'MOZ_NO_REMOTE': '1', 07:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:16 INFO - 'NO_EM_RESTART': '1', 07:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:16 INFO - 'PWD': '/builds/slave/test', 07:34:16 INFO - 'SHELL': '/bin/bash', 07:34:16 INFO - 'SHLVL': '1', 07:34:16 INFO - 'TERM': 'linux', 07:34:16 INFO - 'TMOUT': '86400', 07:34:16 INFO - 'USER': 'cltbld', 07:34:16 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:16 INFO - '_': '/tools/buildbot/bin/python'} 07:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:16 INFO - Downloading/unpacking psutil>=3.1.1 07:34:16 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 07:34:16 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 07:34:16 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 07:34:16 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 07:34:16 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 07:34:16 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 07:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:18 INFO - Installing collected packages: psutil 07:34:18 INFO - Running setup.py install for psutil 07:34:18 INFO - building 'psutil._psutil_linux' extension 07:34:18 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 07:34:18 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 07:34:18 INFO - building 'psutil._psutil_posix' extension 07:34:18 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 07:34:18 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 07:34:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:18 INFO - Successfully installed psutil 07:34:18 INFO - Cleaning up... 07:34:18 INFO - Return code: 0 07:34:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:18 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 0x7f4cbcbd8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, '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': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', '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 07:34:18 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 07:34:18 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 07:34:18 INFO - Using env: {'DISPLAY': ':0', 07:34:18 INFO - 'HOME': '/home/cltbld', 07:34:18 INFO - 'LANG': 'en_US.UTF-8', 07:34:18 INFO - 'LANGUAGE': 'en_US:en', 07:34:18 INFO - 'LOGNAME': 'cltbld', 07:34:18 INFO - 'MAIL': '/var/mail/cltbld', 07:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:18 INFO - 'MOZ_NO_REMOTE': '1', 07:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:18 INFO - 'NO_EM_RESTART': '1', 07:34:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:18 INFO - 'PWD': '/builds/slave/test', 07:34:18 INFO - 'SHELL': '/bin/bash', 07:34:18 INFO - 'SHLVL': '1', 07:34:18 INFO - 'TERM': 'linux', 07:34:18 INFO - 'TMOUT': '86400', 07:34:18 INFO - 'USER': 'cltbld', 07:34:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:18 INFO - '_': '/tools/buildbot/bin/python'} 07:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:34:19 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 07:34:19 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 07:34:19 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 07:34:19 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 07:34:19 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 07:34:19 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 07:34:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:34:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:34:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:34:21 INFO - Installing collected packages: mozsystemmonitor 07:34:21 INFO - Running setup.py install for mozsystemmonitor 07:34:21 INFO - Successfully installed mozsystemmonitor 07:34:21 INFO - Cleaning up... 07:34:21 INFO - Return code: 0 07:34:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:34:21 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')]} 07:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:21 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')]} 07:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:21 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 0x7f4cbcbd8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, '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': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', '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 07:34:21 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 07:34:21 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 07:34:21 INFO - Using env: {'DISPLAY': ':0', 07:34:21 INFO - 'HOME': '/home/cltbld', 07:34:21 INFO - 'LANG': 'en_US.UTF-8', 07:34:21 INFO - 'LANGUAGE': 'en_US:en', 07:34:21 INFO - 'LOGNAME': 'cltbld', 07:34:21 INFO - 'MAIL': '/var/mail/cltbld', 07:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:21 INFO - 'MOZ_NO_REMOTE': '1', 07:34:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:21 INFO - 'NO_EM_RESTART': '1', 07:34:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:21 INFO - 'PWD': '/builds/slave/test', 07:34:21 INFO - 'SHELL': '/bin/bash', 07:34:21 INFO - 'SHLVL': '1', 07:34:21 INFO - 'TERM': 'linux', 07:34:21 INFO - 'TMOUT': '86400', 07:34:21 INFO - 'USER': 'cltbld', 07:34:21 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:21 INFO - '_': '/tools/buildbot/bin/python'} 07:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:21 INFO - Downloading/unpacking jsonschema==2.5.1 07:34:21 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 07:34:21 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 07:34:21 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 07:34:21 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 07:34:21 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 07:34:21 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 07:34:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:34:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:34:23 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 07:34:23 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 07:34:23 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 07:34:23 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 07:34:23 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 07:34:23 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 07:34:23 INFO - Downloading functools32-3.2.3-2.tar.gz 07:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:34:23 INFO - warning: no files found matching '*.txt' 07:34:23 INFO - no previously-included directories found matching 'build' 07:34:23 INFO - no previously-included directories found matching 'dist' 07:34:23 INFO - no previously-included directories found matching '.git*' 07:34:23 INFO - Installing collected packages: jsonschema, functools32 07:34:23 INFO - Running setup.py install for functools32 07:34:23 INFO - warning: no files found matching '*.txt' 07:34:23 INFO - no previously-included directories found matching 'build' 07:34:23 INFO - no previously-included directories found matching 'dist' 07:34:23 INFO - no previously-included directories found matching '.git*' 07:34:23 INFO - Successfully installed jsonschema functools32 07:34:23 INFO - Cleaning up... 07:34:24 INFO - Return code: 0 07:34:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:34:24 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')]} 07:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:24 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')]} 07:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:24 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 0x7f4cbcbd8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, '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': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', '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 07:34:24 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 07:34:24 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 07:34:24 INFO - Using env: {'DISPLAY': ':0', 07:34:24 INFO - 'HOME': '/home/cltbld', 07:34:24 INFO - 'LANG': 'en_US.UTF-8', 07:34:24 INFO - 'LANGUAGE': 'en_US:en', 07:34:24 INFO - 'LOGNAME': 'cltbld', 07:34:24 INFO - 'MAIL': '/var/mail/cltbld', 07:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:24 INFO - 'MOZ_NO_REMOTE': '1', 07:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:24 INFO - 'NO_EM_RESTART': '1', 07:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:24 INFO - 'PWD': '/builds/slave/test', 07:34:24 INFO - 'SHELL': '/bin/bash', 07:34:24 INFO - 'SHLVL': '1', 07:34:24 INFO - 'TERM': 'linux', 07:34:24 INFO - 'TMOUT': '86400', 07:34:24 INFO - 'USER': 'cltbld', 07:34:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:24 INFO - '_': '/tools/buildbot/bin/python'} 07:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:34:24 INFO - Cleaning up... 07:34:24 INFO - Return code: 0 07:34:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:34:24 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')]} 07:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:24 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')]} 07:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:24 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 0x7f4cbcbd8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, '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': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', '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 07:34:24 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 07:34:24 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 07:34:24 INFO - Using env: {'DISPLAY': ':0', 07:34:24 INFO - 'HOME': '/home/cltbld', 07:34:24 INFO - 'LANG': 'en_US.UTF-8', 07:34:24 INFO - 'LANGUAGE': 'en_US:en', 07:34:24 INFO - 'LOGNAME': 'cltbld', 07:34:24 INFO - 'MAIL': '/var/mail/cltbld', 07:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:24 INFO - 'MOZ_NO_REMOTE': '1', 07:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:24 INFO - 'NO_EM_RESTART': '1', 07:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:24 INFO - 'PWD': '/builds/slave/test', 07:34:24 INFO - 'SHELL': '/bin/bash', 07:34:24 INFO - 'SHLVL': '1', 07:34:24 INFO - 'TERM': 'linux', 07:34:24 INFO - 'TMOUT': '86400', 07:34:24 INFO - 'USER': 'cltbld', 07:34:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:24 INFO - '_': '/tools/buildbot/bin/python'} 07:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:24 INFO - Downloading/unpacking blobuploader==1.2.4 07:34:24 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 07:34:24 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 07:34:24 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 07:34:24 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 07:34:24 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 07:34:24 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 07:34:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:34:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:34:26 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 07:34:26 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 07:34:26 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 07:34:26 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 07:34:26 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 07:34:26 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 07:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:26 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 07:34:26 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 07:34:26 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 07:34:26 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 07:34:26 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 07:34:26 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 07:34:27 INFO - Downloading docopt-0.6.1.tar.gz 07:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:27 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:27 INFO - Running setup.py install for blobuploader 07:34:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:27 INFO - Running setup.py install for requests 07:34:27 INFO - Running setup.py install for docopt 07:34:27 INFO - Successfully installed blobuploader requests docopt 07:34:27 INFO - Cleaning up... 07:34:27 INFO - Return code: 0 07:34:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:27 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 0x7f4cbcbd8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, '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': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', '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 07:34:27 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 07:34:27 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 07:34:27 INFO - Using env: {'DISPLAY': ':0', 07:34:27 INFO - 'HOME': '/home/cltbld', 07:34:27 INFO - 'LANG': 'en_US.UTF-8', 07:34:27 INFO - 'LANGUAGE': 'en_US:en', 07:34:27 INFO - 'LOGNAME': 'cltbld', 07:34:27 INFO - 'MAIL': '/var/mail/cltbld', 07:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:27 INFO - 'MOZ_NO_REMOTE': '1', 07:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:27 INFO - 'NO_EM_RESTART': '1', 07:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:27 INFO - 'PWD': '/builds/slave/test', 07:34:27 INFO - 'SHELL': '/bin/bash', 07:34:27 INFO - 'SHLVL': '1', 07:34:27 INFO - 'TERM': 'linux', 07:34:27 INFO - 'TMOUT': '86400', 07:34:27 INFO - 'USER': 'cltbld', 07:34:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:27 INFO - '_': '/tools/buildbot/bin/python'} 07:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:28 INFO - Running setup.py (path:/tmp/pip-9awEdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:28 INFO - Running setup.py (path:/tmp/pip-x9JyaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:28 INFO - Running setup.py (path:/tmp/pip-42hw5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:28 INFO - Running setup.py (path:/tmp/pip-agbcvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:28 INFO - Running setup.py (path:/tmp/pip-rFp2ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:28 INFO - Running setup.py (path:/tmp/pip-qdHfhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:28 INFO - Running setup.py (path:/tmp/pip-m_2l8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:28 INFO - Running setup.py (path:/tmp/pip-mPfsqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:28 INFO - Running setup.py (path:/tmp/pip-UJ_lpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:28 INFO - Running setup.py (path:/tmp/pip-A_8oCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:28 INFO - Running setup.py (path:/tmp/pip-rU0Mga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:28 INFO - Running setup.py (path:/tmp/pip-_BWaz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:28 INFO - Running setup.py (path:/tmp/pip-8JoHvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:29 INFO - Running setup.py (path:/tmp/pip-znNo6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:29 INFO - Running setup.py (path:/tmp/pip-kYdiuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:29 INFO - Running setup.py (path:/tmp/pip-n9FWBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:29 INFO - Running setup.py (path:/tmp/pip-EG1VJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:29 INFO - Running setup.py install for manifestparser 07:34:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Running setup.py install for mozcrash 07:34:29 INFO - Running setup.py install for mozdebug 07:34:29 INFO - Running setup.py install for mozdevice 07:34:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Running setup.py install for mozfile 07:34:29 INFO - Running setup.py install for mozhttpd 07:34:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Running setup.py install for mozinfo 07:34:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:29 INFO - Running setup.py install for mozInstall 07:34:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:30 INFO - Running setup.py install for mozleak 07:34:30 INFO - Running setup.py install for mozlog 07:34:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:30 INFO - Running setup.py install for moznetwork 07:34:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:30 INFO - Running setup.py install for mozprocess 07:34:30 INFO - Running setup.py install for mozprofile 07:34:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:34:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:34:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:34:30 INFO - Running setup.py install for mozrunner 07:34:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:34:30 INFO - Running setup.py install for mozscreenshot 07:34:30 INFO - Running setup.py install for moztest 07:34:30 INFO - Running setup.py install for mozversion 07:34:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:34:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:34:31 INFO - Cleaning up... 07:34:31 INFO - Return code: 0 07:34:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:31 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 0x7f4cbcbd8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, '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': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', '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 07:34:31 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 07:34:31 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 07:34:31 INFO - Using env: {'DISPLAY': ':0', 07:34:31 INFO - 'HOME': '/home/cltbld', 07:34:31 INFO - 'LANG': 'en_US.UTF-8', 07:34:31 INFO - 'LANGUAGE': 'en_US:en', 07:34:31 INFO - 'LOGNAME': 'cltbld', 07:34:31 INFO - 'MAIL': '/var/mail/cltbld', 07:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:31 INFO - 'MOZ_NO_REMOTE': '1', 07:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:31 INFO - 'NO_EM_RESTART': '1', 07:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:31 INFO - 'PWD': '/builds/slave/test', 07:34:31 INFO - 'SHELL': '/bin/bash', 07:34:31 INFO - 'SHLVL': '1', 07:34:31 INFO - 'TERM': 'linux', 07:34:31 INFO - 'TMOUT': '86400', 07:34:31 INFO - 'USER': 'cltbld', 07:34:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:31 INFO - '_': '/tools/buildbot/bin/python'} 07:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:31 INFO - Running setup.py (path:/tmp/pip-BvfhWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:31 INFO - Running setup.py (path:/tmp/pip-RxHK46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:31 INFO - Running setup.py (path:/tmp/pip-BIFhM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:31 INFO - Running setup.py (path:/tmp/pip-886iHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:31 INFO - Running setup.py (path:/tmp/pip-tj35Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:31 INFO - Running setup.py (path:/tmp/pip-5gRhEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:31 INFO - Running setup.py (path:/tmp/pip-CKktFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:31 INFO - Running setup.py (path:/tmp/pip-dg0m9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:31 INFO - Running setup.py (path:/tmp/pip-cPXjFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:31 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)) 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:31 INFO - Running setup.py (path:/tmp/pip-LYdcDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:32 INFO - Running setup.py (path:/tmp/pip-ROZF4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:32 INFO - Running setup.py (path:/tmp/pip-6FEX9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:32 INFO - Running setup.py (path:/tmp/pip-JNsMIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:32 INFO - Running setup.py (path:/tmp/pip-6tOVpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:32 INFO - Running setup.py (path:/tmp/pip-LmCBR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:32 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)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:32 INFO - Running setup.py (path:/tmp/pip-ZGiAVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:32 INFO - Running setup.py (path:/tmp/pip-T6wAgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 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)) 07:34:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34:32 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 07:34:32 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 07:34:32 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 07:34:32 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 07:34:32 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 07:34:32 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 07:34:34 INFO - Downloading blessings-1.6.tar.gz 07:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:34:34 INFO - Installing collected packages: blessings 07:34:34 INFO - Running setup.py install for blessings 07:34:34 INFO - Successfully installed blessings 07:34:34 INFO - Cleaning up... 07:34:34 INFO - Return code: 0 07:34:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:34:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:34 INFO - Reading from file tmpfile_stdout 07:34:34 INFO - Current package versions: 07:34:34 INFO - argparse == 1.2.1 07:34:34 INFO - blessings == 1.6 07:34:34 INFO - blobuploader == 1.2.4 07:34:34 INFO - docopt == 0.6.1 07:34:34 INFO - functools32 == 3.2.3-2 07:34:34 INFO - jsonschema == 2.5.1 07:34:34 INFO - manifestparser == 1.1 07:34:34 INFO - mozInstall == 1.12 07:34:34 INFO - mozcrash == 1.0 07:34:34 INFO - mozdebug == 0.1 07:34:34 INFO - mozdevice == 0.49 07:34:34 INFO - mozfile == 1.2 07:34:34 INFO - mozhttpd == 0.7 07:34:34 INFO - mozinfo == 0.9 07:34:34 INFO - mozleak == 0.1 07:34:34 INFO - mozlog == 3.4 07:34:34 INFO - moznetwork == 0.27 07:34:34 INFO - mozprocess == 0.23 07:34:34 INFO - mozprofile == 0.28 07:34:34 INFO - mozrunner == 6.13 07:34:34 INFO - mozscreenshot == 0.1 07:34:34 INFO - mozsystemmonitor == 0.3 07:34:34 INFO - moztest == 0.7 07:34:34 INFO - mozversion == 1.4 07:34:34 INFO - psutil == 3.1.1 07:34:34 INFO - requests == 1.2.3 07:34:34 INFO - wsgiref == 0.1.2 07:34:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:34 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 0x7f4cbcbd8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, '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': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', '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 07:34:34 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 07:34:34 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 07:34:34 INFO - Using env: {'DISPLAY': ':0', 07:34:34 INFO - 'HOME': '/home/cltbld', 07:34:34 INFO - 'LANG': 'en_US.UTF-8', 07:34:34 INFO - 'LANGUAGE': 'en_US:en', 07:34:34 INFO - 'LOGNAME': 'cltbld', 07:34:34 INFO - 'MAIL': '/var/mail/cltbld', 07:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:34 INFO - 'MOZ_NO_REMOTE': '1', 07:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:34 INFO - 'NO_EM_RESTART': '1', 07:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:34 INFO - 'PWD': '/builds/slave/test', 07:34:34 INFO - 'SHELL': '/bin/bash', 07:34:34 INFO - 'SHLVL': '1', 07:34:34 INFO - 'TERM': 'linux', 07:34:34 INFO - 'TMOUT': '86400', 07:34:34 INFO - 'USER': 'cltbld', 07:34:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:34 INFO - '_': '/tools/buildbot/bin/python'} 07:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 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)) 07:34:35 INFO - Cleaning up... 07:34:35 INFO - Return code: 0 07:34:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:35 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 0x7f4cbcbd8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, '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': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', '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 07:34:35 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 07:34:35 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 07:34:35 INFO - Using env: {'DISPLAY': ':0', 07:34:35 INFO - 'HOME': '/home/cltbld', 07:34:35 INFO - 'LANG': 'en_US.UTF-8', 07:34:35 INFO - 'LANGUAGE': 'en_US:en', 07:34:35 INFO - 'LOGNAME': 'cltbld', 07:34:35 INFO - 'MAIL': '/var/mail/cltbld', 07:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:35 INFO - 'MOZ_NO_REMOTE': '1', 07:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:35 INFO - 'NO_EM_RESTART': '1', 07:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:35 INFO - 'PWD': '/builds/slave/test', 07:34:35 INFO - 'SHELL': '/bin/bash', 07:34:35 INFO - 'SHLVL': '1', 07:34:35 INFO - 'TERM': 'linux', 07:34:35 INFO - 'TMOUT': '86400', 07:34:35 INFO - 'USER': 'cltbld', 07:34:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:35 INFO - '_': '/tools/buildbot/bin/python'} 07:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:34:35 INFO - Cleaning up... 07:34:35 INFO - Return code: 0 07:34:35 INFO - Running post-action listener: _resource_record_post_action 07:34:35 INFO - Running post-action listener: _start_resource_monitoring 07:34:35 INFO - Starting resource monitoring. 07:34:35 INFO - [mozharness: 2016-12-10 15:34:35.456635Z] Finished create-virtualenv step (success) 07:34:35 INFO - [mozharness: 2016-12-10 15:34:35.457114Z] Running install step. 07:34:35 INFO - Running pre-action listener: _resource_record_pre_action 07:34:35 INFO - Running main action method: install 07:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:35 INFO - Reading from file tmpfile_stdout 07:34:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:34:35 INFO - Reading from file tmpfile_stdout 07:34:35 INFO - Output received: 07:34:35 INFO - Usage: mozinstall [options] installer 07:34:35 INFO - Options: 07:34:35 INFO - -h, --help show this help message and exit 07:34:35 INFO - -d DEST, --destination=DEST 07:34:35 INFO - Directory to install application into. [default: 07:34:35 INFO - "/builds/slave/test"] 07:34:35 INFO - --app=APP Application being installed. [default: firefox] 07:34:35 INFO - mkdir: /builds/slave/test/build/application 07:34:35 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'] 07:34:35 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 07:34:51 INFO - Reading from file tmpfile_stdout 07:34:51 INFO - Output received: 07:34:51 INFO - /builds/slave/test/build/application/firefox/firefox 07:34:51 INFO - Running post-action listener: _resource_record_post_action 07:34:51 INFO - [mozharness: 2016-12-10 15:34:51.865768Z] Finished install step (success) 07:34:51 INFO - [mozharness: 2016-12-10 15:34:51.866009Z] Running run-tests step. 07:34:51 INFO - Running pre-action listener: _resource_record_pre_action 07:34:51 INFO - Running main action method: run_tests 07:34:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:34:51 INFO - Python 2.7.3 07:34:51 INFO - Return code: 0 07:34:51 INFO - grabbing minidump binary from tooltool 07:34:51 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')]} 07:34:51 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 0x262df20>, '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 0x259ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:34:51 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 07:34:51 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 07:34:51 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 07:34:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:34:51 INFO - Return code: 0 07:34:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:34:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:34:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:34:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:34:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:34:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 07:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 07:34:51 INFO - Using env: {'DISPLAY': ':0', 07:34:51 INFO - 'HOME': '/home/cltbld', 07:34:51 INFO - 'LANG': 'en_US.UTF-8', 07:34:51 INFO - 'LANGUAGE': 'en_US:en', 07:34:51 INFO - 'LOGNAME': 'cltbld', 07:34:51 INFO - 'MAIL': '/var/mail/cltbld', 07:34:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:34:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:51 INFO - 'MOZ_NO_REMOTE': '1', 07:34:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:34:51 INFO - 'NO_EM_RESTART': '1', 07:34:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:51 INFO - 'PWD': '/builds/slave/test', 07:34:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:34:51 INFO - 'SHELL': '/bin/bash', 07:34:51 INFO - 'SHLVL': '1', 07:34:51 INFO - 'TERM': 'linux', 07:34:51 INFO - 'TMOUT': '86400', 07:34:51 INFO - 'USER': 'cltbld', 07:34:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296', 07:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:51 INFO - '_': '/tools/buildbot/bin/python'} 07:34:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 07:34:52 INFO - mozversion application_buildid: 20161210063617 07:34:52 INFO - mozversion application_changeset: 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b 07:34:52 INFO - mozversion application_display_name: Nightly 07:34:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:34:52 INFO - mozversion application_name: Firefox 07:34:52 INFO - mozversion application_remotingname: firefox 07:34:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:34:52 INFO - mozversion application_vendor: Mozilla 07:34:52 INFO - mozversion application_version: 53.0a1 07:34:52 INFO - mozversion platform_buildid: 20161210063617 07:34:52 INFO - mozversion platform_changeset: 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b 07:34:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:34:52 INFO - mozversion platform_version: 53.0a1 07:34:52 INFO - using testdate: 1481384092 07:34:52 INFO - actual date: 1481384092 07:34:52 INFO - starting webserver on 'localhost:47215' 07:34:52 INFO - SUITE-START | Running 2 tests 07:34:52 INFO - TEST-START | dromaeo_css 07:34:52 INFO - operating with platform_type : linux_ 07:34:52 INFO - Initialising browser for dromaeo_css test... 07:34:52 INFO - TEST-INFO | started process 3490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaX3V89/profile http://localhost:47215/getInfo.html) 07:34:56 INFO - PROCESS | 3490 | __metrics Screen width/height:1600/1200 07:34:56 INFO - PROCESS | 3490 | colorDepth:24 07:34:56 INFO - PROCESS | 3490 | Browser inner width/height: 1024/697 07:34:56 INFO - PROCESS | 3490 | __metrics 07:34:57 INFO - PROCESS | 3490 | 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" 07:34:57 INFO - PROCESS | 3490 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:34:57 INFO - PROCESS | 3490 | console.error: PushService: 07:34:57 INFO - PROCESS | 3490 | stateChangeProcessEnqueue: Error transitioning state 07:34:57 INFO - PROCESS | 3490 | UnknownError 07:34:58 INFO - TEST-INFO | 3490: exit 0 07:34:58 INFO - Browser initialized. 07:34:58 INFO - Running cycle 1/1 for dromaeo_css test... 07:34:58 INFO - TEST-INFO | started process 3572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaX3V89/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:10 INFO - PROCESS | 3572 | RSS: Main: 173764608 07:35:10 INFO - PROCESS | 3572 | 07:36:02 INFO - PROCESS | 3572 | 1481384162038 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:38:15 INFO - PROCESS | 3572 | Cycle 1(1): loaded http://localhost:47215/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47215/tests/dromaeo/cssquery-ext.html) 07:38:18 INFO - PROCESS | 3572 | RSS: Main: 395386880 07:38:18 INFO - PROCESS | 3572 | 07:41:21 INFO - PROCESS | 3572 | Cycle 1(1): loaded http://localhost:47215/tests/dromaeo/cssquery-ext.html (next: http://localhost:47215/tests/dromaeo/cssquery-jquery.html) 07:41:21 INFO - PROCESS | 3572 | RSS: Main: 285446144 07:41:21 INFO - PROCESS | 3572 | 07:44:24 INFO - PROCESS | 3572 | Cycle 1(1): loaded http://localhost:47215/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47215/tests/dromaeo/cssquery-mootools.html) 07:44:24 INFO - PROCESS | 3572 | RSS: Main: 219353088 07:44:24 INFO - PROCESS | 3572 | 07:47:27 INFO - PROCESS | 3572 | Cycle 1(1): loaded http://localhost:47215/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47215/tests/dromaeo/cssquery-prototype.html) 07:47:27 INFO - PROCESS | 3572 | RSS: Main: 222302208 07:47:27 INFO - PROCESS | 3572 | 07:50:30 INFO - PROCESS | 3572 | Cycle 1(1): loaded http://localhost:47215/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47215/tests/dromaeo/cssquery-yui.html) 07:50:31 INFO - PROCESS | 3572 | RSS: Main: 224784384 07:50:31 INFO - PROCESS | 3572 | 07:53:34 INFO - PROCESS | 3572 | Cycle 1(1): loaded http://localhost:47215/tests/dromaeo/cssquery-yui.html (next: http://localhost:47215/tests/dromaeo/cssquery-dojo.html) 07:53:35 INFO - PROCESS | 3572 | RSS: Main: 312983552 07:53:35 INFO - PROCESS | 3572 | 07:53:35 INFO - PROCESS | 3572 | __start_tp_report 07:53:35 INFO - PROCESS | 3572 | _x_x_mozilla_page_load 07:53:35 INFO - PROCESS | 3572 | _x_x_mozilla_page_load_details 07:53:35 INFO - PROCESS | 3572 | |i|pagename|runs| 07:53:35 INFO - PROCESS | 3572 | |0;dojo.html;2547.9490410191797;2573.2151693733404;2580.896764129435;2582.0317380982133;2593.0016943476758;4434.534373890743;4484.484284307306;4497.527759585246;4515.796789144488;4519.638428925687;4509.977450112745;4525.34382514536;4538.205813982557;4556.111558246143;4569.177548041352;4164.875053748392;4194.727342722713;4217.472815898012;4218.147006910591;4282.14357128574;3902.5443012437654;4272.658187345005;4273.145370925828;4292.549282325358;4343.826246950118;4120.7321524100835;4138.379243113527;4150.439690641755;4286.421333120051;4301.870943871689;4179.373094035888;4183.079722461053;4184.4141820145205;4186.5604111568155;4198.03445207604;4188.057687020427;4203.096334288142;4225.239456897757;4231.048014196812;4249.830006799724;4538.047010127877;4540.046590216059;4552.817887284505;4571.428571428572;4587.541245875419;4759.643026773006;4804.807807687724;4806.279058141272;4843.22508398658;4851.805927762885;4871.634627402924;4880.853574392739;4888.780004899788;4889.975550122263;4893.339399181136;4553.908921821579;4566.315052742115;4566.543345665407;4568.428946381702;4574.222382195035;4937.284093806378;4973.05511952735;4977.278294647256;4979.800807967641;4989.800407983713;4698.506656800987;4786.1624215762795;4797.712137271775;4799.496052914464;4804.855854324376;4823.2282834746275;4895.828645997373;4899.681520701143;4907.386576677915;4908.435529914105;4785.425748910153;4799.832005879777;4815.855524334275;4816.109019831342;4856.78144483492;4785.521447855187;4790.808367665254;4792.065547218259;4796.088743138793;4839.588634966068;3913.295606790805;3938.547067087264;3939.803009849496;3968.4840970673627;3974.0859602291634;3520.1023738946915;3520.859165633346;3552.9644703552635;3555.662212089899;3559.128013636624;4238.660907127422;4248.553901840324;4256.7445953242905;4258.893527661771;4279.379489973936;4815.855524334275;4852.56326930578;4869.9513004870205;4875.463698993108;4877.12211801879;4264.616184543344;4295.699301048959;4298.591633794785;4320.740755554677;4324.481062272547;4355.912881742347;4358.760268185217;4361.847335343247;4388.890277743082;4396.9120617588105;4538.455385353646;4579.633629309581;4645.488996210346;4649.163150632919;4686.461056978491;4884.291777692144;4886.511348865085;4899.877503062452;4900.019996000743;4902.166631672696;4560.065186636798;4614.607758340444;4624.861254162381;4626.976865115787;4629.699069560468;4793.976030119827;4794.976025119852;4798.088363210979;4798.1123492154065;4802.615790736802;4821.228603423436;4860.95139048605;4869.464358920445;4870.610351171827;4870.805167793249;4709.481956984798;4739.146953548395;4741.122892264942;4744.098621261949;4746.121967436035;4716.575508204278;4735.171345014677;4738.786754596121;4745.47799742035;4750.857474275777;4680.695754775928;4737.455192652889;4740.3837501124635;4746.216874215854;4793.832215872428;4823.686460380064;4831.323614693875;4839.491853355347;4842.443119041355;4880.463149053672;4593.104344652761;4624.28323609841;4646.8141274348645;4655.2784318430695;4659.627229821538 07:53:35 INFO - PROCESS | 3572 | |1;ext.html;525.4823998361616;533.4851867947431;546.0825812634772;548.106586264389;561.3011800308616;26668.599971000425;29391.706082939192;29507.114786556413;35479.4678079829;37271;37709.43435848458;38042.80978595103;38065;38159;38190.23619527615;7296.197418283985;7470.626468676572;7473.327400533951;7475.514091584029;7484.064491938508;7231.313025262618;7401.666924988388;7414;9076.503961410632;9337.953310233439;9322.62709491623;9389.436633801959;9405.200557952583;9406.670766523173;9419.905800941971;9567.473788941605;9593.136617704371;9595.376300540442;9685.176759975411;9686.612535498607;9075.636974521078;9163.22112620428;9164.312676549285;9172.312076594282;9172.357934944557;34900.65099349025;35067.649323506696;35305.293894121976;35336.46995295073;35701.46447803285;2930.428566429547;3022.7128422799797;3082.537619357092;3292.917677058069;3301.851416686231;26659.20022399331;26859.731402685917;27068.1879543614;27533.586996195074;27711.307217319525;3248.545203671488;3301.125201821495;3331.53358529806;3378.9662103378896;3402.030421329909;184749;228121;230461;230648;230817;51664;52490.21264681033;52629.473705263226;52631.73684131555;52638.73680631573;55028.174577381375;55855.441445585835;55956.72021639866;55959.160612590844;56019;12805.743885122245;13032.218066916015;13041;13044.869551304366;13048.151870128411;8767.342449316327;9391;9452.291078169164;9463.479508626953;9470.621175152917;15418.537443876701;18149.909250453664;18687.906560467112;18725.719114213298;19380.70928936067;6780.525363224527;7257.818554536073;7381.520201186906;7383.704651813868;7431.405487560982;805.8388322335556;901.4095767272447;918.4902379179485;951.7097285328041;985.763416779982;26209.344766380993;27099.729002710115;28781.85609071941;30348;30868.845655772027;915.9514943947767;916.3768637326682;938.8357037518407;953.4231789767091;953.8903026151943;13829.585112446643;14501.347439365254;14525.983181177427;14541.78187327191;14663.706725865422;315418;323094;323922;324398;325070;46011;46390;46465.7676711621;46597;46603.30095048577;1168.6435637130587;1196.9341686207342;1205.5177928828539;1209.6431552691802;1211.854577450694;24215.394615134763;24262.393440164138;26035.479290414463;26469;28462;39774.403383949844;40354.596454036255;40400;40433.191336172524;40480.59519404768;313553;317686;318162;318683;318710;32032.67967320297;32233;33044;33240.1689957753;35968.820155899055;30732;35030.64969350376;36050.27899442049;42463;44979.32531011972;34636;35246.823765881;35325.47011794877;35534.28931421409;35612.28775424529;34382.82808586041;34433.655663443045;34811.825940870134;35004.47493287552;35027.649723502436;33981.49027764536;34343.13137372486;34573.13567160841;34789.65210347864;34790.30419391648;30280.84859575688;31574.60472098105;31698.366032679678;31796;32513.187170320933;24856;25040.123595674064;25103.87448062748;25123.467898346196;25461.618075728507 07:53:35 INFO - PROCESS | 3572 | |2;jquery.html;332.5610194543201;343.6305971081089;361.75400727505297;366.72678854253576;381.81481981239097;15228.54314370568;15973.281202345894;16655;16854.494365169034;16871;15743.763843542356;16087.436939707113;16211.270492827822;16315.021098734085;16375.83624163758;4412.713173643711;4877;4901.1177987962155;4905.607551395898;4913.091078150535;3584.4623306503972;3778.792166430845;4758.976205118969;4849.224124140138;4851.59303801897;5326.147816349385;5572.219889215513;5599.776008959637;5690.459406356389;5691.8577035574235;5453.754581043862;5576.442355764431;5596.804111856066;5662.433756624325;5676.460736230072;4922.581580565657;4925.064237794843;4927.926081108786;4928.48250933654;4938.4814594467425;17708.557286067822;18340;18463.538411539685;18610.16254268561;19511.512212194666;1760.9647807043916;1827.1412436154985;1908.2557802457052;2029.9289524866558;2306.423394151462;8779.209871111567;9212.216961558275;9748.415095094317;10109.949450252776;12919.483220671162;1639.2787173643678;1685.1658429077563;1707.4109432245855;1715.785526809149;1752.6582316448298;58694.902290145095;59468.40531594672;61892.69053654748;62414.37585624131;63726.0441093384;9250.67622633218;9432.151106400319;9491.430514169035;9550.087223396931;9896.356736812084;12990.090693651353;13068.869311306955;13108.672283192996;13133.934330328479;13146.4084116215;6486.286508484063;6663.733450662016;6716.597004179765;6890;6908.965455172692;6201.782937597162;6209.441150296495;6349.587276826992;6377.585456945284;6378.234611846516;3856.151646637735;3883;4204.957950420457;4229.407882896397;4288.571142885687;1668.1909274002098;1722.6985277576625;1769.51338381946;1775.2987569909812;1787.4548262779977;684.260998122027;818.6111596991501;862.4643547968951;914.4513292024732;954.9331546791797;14734.189619570812;15774.211289435712;16115.435959741353;16151.919240403959;16833;802.0856223904754;807.3984881263497;811.5536454949754;817.5952903312898;822.8930239068883;8841.248493877963;9414.764630884145;9450.338476306593;9465.716028519155;9646.614135434644;332137;335908;336906;338344;352209;74562.6271868648;74791;74831.25168748242;75367;78146.6092669533;855.3969451536652;883.077184342351;902.0213068820273;903.746950853762;904.1771987491483;14537.491187808377;14723.190224537753;15274.389024438899;15463.84536154624;15506.84493155054;34691;34728.65271347355;34797.13007174841;35599;36322.636773632985;45484.54515454803;47702.284465733734;47748.65759396948;48548.514514855815;50404.24393634025;7182.96408517954;7268.382187513909;7364.521306115085;7444.627768611656;7512.21121782205;8200.58997050157;10421.68734937953;10953.17851161182;11050.944745276222;11760.05919526453;8929.73210803677;9108.544572771467;9734.853977190489;9804.460754658277;10247.231457640557;9890.505474726378;9928.75178120524;10130.594776209164;10153.492325383553;10169.491525423848;8951.865722014045;9445.291603129655;9586.520673966414;9757.073078057572;10228.232882533692;6382.457491113308;6617.139771829631;6655.068290439245;6923.342282483156;7459.216782237787;7225.349718525358;9725.610975560898;9915.65295214664;10037.946015668542;10309.587616495557 07:53:35 INFO - PROCESS | 3572 | |3;mootools.html;1056;1073.8603981482408;1123.1800785426638;1447.8190226221716;1624.87813413994;6467.579607325521;6745.460363170947;6756.054152418666;6796.048553202556;6879.72481100756;6063.211782468284;6226.06609008649;6533.8039858804195;6730.326967303267;6730.394264516192;1964.6365422396866;2019.474936516509;2021.9898900505477;2022.7168196452508;2023.979760202394;1932.9516762080991;2032.3699653107583;2033.1460786469645;2055.219016773624;2057.9298764642376;1729.7578339032546;1788.7227479740661;1887.7545919030506;1963.4600484866633;2001.1995201919203;2001.2195243854762;2001.3595649392128;2001.8698784578955;2001.909914053871;2002.2391491233384;2002.9784809747134;2013.617412691584;2025.4328787939253;2032.5121970727066;2034.267663641103;6661.367170118831;6734.225564060147;6754.8311292217595;6785.117934668461;6847.417969472601;3995.860144894915;4120.567340429242;4121.855735049289;4125.278076336629;4132.73137246081;2543.682039745032;2655.5751079827137;2678.450917561895;2694.380292532709;2719.048333083425;817.1379194949326;862.5299211929513;874.868769684546;888.3958907942597;910.9180173784391;8702.260307873838;8756.518391488466;8762.474251544927;8767.167119123673;8777.51723655205;3549.343371476285;3645;3692.6122757110115;3728.5339332583426;3730.68289195416;7719.3052625264;7782.416318776114;7790.98717166776;7802.921970780333;7805.765827025199;3958.841646334172;3962.484876965976;3964.5044369453817;4007.599240075969;4008.779517126586;3600.801955892399;3710.7588006779474;3748.55017397914;3803.4865293185067;3806.5051543299196;3052.2064263291704;3113.7508999280003;3122.656507784142;3139.7331226845517;3202.4235637584993;960.1454705312277;968.1141755293827;973.6494861849728;975.8292298847673;979.2117345536911;729.3873146556917;738.918718940916;773.5126870071931;779.3453499060817;861.6811779641573;4789.401324834395;4799.736014519235;4880.389951256093;4971.577415919687;5134.2298655201275;800.87986801979;872.1757938747822;877.3288434347729;883.5935469683889;885.5527958380976;3272.181954511372;3329.3174899145615;3362.277110421271;3430.1939044324563;3513.8243087845503;7712.228777122243;7918.683252669944;7955.681772729026;8140.511569305861;8197.385196110316;8149.185081491803;8168.836623267502;8173.959130204311;8198.098209196984;8201.261886430131;6076.51387888959;6160.599561028519;6265.310815810257;6277.309495955441;6285.465735412541;4739.502352252964;4918.458969513422;4923.163062279493;4990.8253211137435;5158.767855446589;7336.37640800538;7354;7471.775846724607;7546.6981320748755;7650.961745191238;7332.633368331669;7432.665530051053;7443.0324057874295;7487.925120748723;7604.42966777505;5805.94194058054;5919.881602368015;5936.406359364029;5978.192943952511;6054.75780968774;6501.674916254263;6506.056621789909;6532.510061745293;6537.28089910119;6584.242812076673;5957.608174995911;6028.457438830526;6032.33644299118;6103.69481525913;6119.632822030692;5868.94131058684;5927.851803704942;5927.911081333697;5972.432618901197;6037.9094313584455;5579.386267510652;5651.406602306699;5665.49010589049;5712.6286791358425;5722.055860782924;4256.212600668886;4285.91428171441;4323.78381080951;4359.956400436082;4495.325701144854;4297.957020429881;4335.609795118455;4355.695101342875;4442.533533979015;4482.955170448254 07:53:35 INFO - PROCESS | 3572 | |4;prototype.html;329.20496999745615;337.8293961549418;338.75271052131944;349.41647448760585;352.9435290353544;4640.814367425299;4660.1844677181525;4662.463816661081;4667.789949452274;4692.583319590413;4582.404287442636;4591.428799872066;4600.861974140773;4613.723176609397;4652.255639097745;3554.36021516127;3651.379265524867;3661.7253705972025;3716.498272733187;3733.5146430963937;3741.812909354535;3751.7936513491745;3752.4802455005765;3767.5699174032734;3773.9056523586855;3716.646918542734;3735.234276973214;3736.7010639148803;3738.401855703088;3739.8317075731657;3547.343741407835;3624.5831729351066;3640.6177351378255;3730.421784623388;3755.380362240227;3356.9832150839334;3357.9160520986925;3362.9327413451592;3364.49532570114;3365.326934613063;4500.189965806154;4527.547245275479;4528.388667529907;4532.4787649420405;4536.977315113436;4095.24238015968;4241.809118589671;4243.554426785205;4248.277792775236;4253.51084625269;4804.375431193957;4842;4849.454036630762;4854.737768180264;4865.5134486551415;3655.2089476156757;3660.5790334111384;3661.4324779659196;3663.8534458621625;3668.8899333020054;5053.191489361684;5070.847874563769;5071.6053085401445;5071.797128114871;5078.390593128848;3305.2067503799394;3491.738119641037;3515.9472607910902;3531.2584357284745;3532.434810430319;3553.626869178751;3553.9289214216087;3570.1610121621397;3575.481555174485;3577.463380492895;4032;4047.0169616887515;4047.170330082326;4047.736897101679;4057.1479989202007;4732;4805.7597120143855;4821.107335598613;4841.830535931296;4864.221724524059;1206.1858245684127;1211.9636410907688;1216.7627312673944;1217.9817302740466;1218.695326168458;803.4978138663336;821.7945513621595;828.3828547731978;828.5691440450931;830.7424698343533;4200.5799420058365;4227.964148783568;4279.443672322641;4306.698531102856;4338.464151716341;4967.230079337708;4995.925061124013;5012.824551140692;5017.874553136201;5027.748612569357;4362.323839804835;4363.214621368184;4364.75993820343;4364.978175109104;4371.956280437218;2520.9495810083695;2578.3296342950966;2580.903116175618;2591.2226332100295;2601.713811480736;4543.341215523797;4617.238155704338;4622.121796858586;4623;4637.559431853969;4988.351514303117;5000.749962501933;5001.89996200074;5009.44896061433;5010.89978200434;4467.642588592905;4543.4093567836635;4587.655925805578;4587.7706114693465;4642.419697537808;4817.855464336076;4842.201036829025;4847.515248475124;4864.610831133572;4869.391326084239;4743.9525604744895;4744.169770290255;4786.186348320724;4787.688800227974;4790.856274311776;4412.889677758082;4595.425571803525;4630.259158534618;4635.582797548237;4649.674522783373;3445.3109378123972;3452;3453.204333746488;3461.394256005239;3463.7575369723877;4877.487863774394;4882.194437917846;4885.462599114166;4897.804087836446;4903.33804936329;4465.9854598145475;4723.952760472352;4743.857684269477;4757.690750101232;4783.736894470838;4714.528547145258;4726.692764970266;4739.478657347758;4743.478217396015;4748.40928289027;4672.462666793226;4676.345311656439;4678.672492925599;4698.859034228979;4705.106029854317;4626.236670949255;4712.646551508719;4771.95228047715;4788.090262850047;4800.831970881002;4586.220342541709;4599.793009314522;4611.700239484423;4643.976780116078;4648.674592778609 07:53:35 INFO - PROCESS | 3572 | |5;yui.html;647.41085612093;648.701597265258;662.4071456046838;669.2136739331286;727.6870945493438;12241.510339586417;13307;13312.267825269606;13317.933410332947;13320.7335853283;12464.563740269092;12554.43505042273;12562.309073001004;12602.054845886549;12659.55691550796;605.966671833049;621.4313902778952;722.137046229757;731.2322061835079;743.1490942870411;742.1650643026595;758.7192738686693;759.0511860174781;759.1270039454616;760.4448752410743;790.8181118342785;791.9506653683892;793.1632128104876;793.2900054451292;793.3256731777972;635.5709895820349;640.9294977552465;768.0744702633314;783.902012248469;785.5286827903269;575.1602660116193;575.3987083497755;575.65748379714;575.772569834917;576.0638961687258;12322.445489952974;12325.815112773316;12333.93833030829;12360.629181124581;12376.752464950741;12852.376192820419;12984.220946743226;12985.22088674673;13005.219686818726;13216.471341146342;11701.53193872244;11869.109816763777;11966.82049769254;11980.580679676257;12256.203346782431;3945.3687410014545;3959.3467077932105;4021.4973128358956;4066.064805094845;4074.3888416737727;61829;63163;63299.05051424279;64990.3500964989;65822.67088664573;10117.696469105938;10174.186065114773;10175.643852465128;10234.980198856256;10476.371417714809;19455.90272048631;19493.610127797365;19527.804721952598;19533.218671253275;19607.705884411746;6586.308437614078;6624;6754.425873800782;6779.694913728894;6840.179178498612;3552.662497062775;3573.874914377984;3625.818709064536;3644.653757892996;3741.6258374162367;2635.907743229016;2695.5417579011614;2709.0653724465424;2724.7547720705234;2738.87675054623;460.8133705849136;462.90973260213934;468.2461237407771;468.9624830013591;481.53772378516317;499.51796516361156;537.1834811087203;537.819830356827;542.579500886808;556.3157316500726;7284.6721897514735;8792.648294068165;9302.488363140092;9385.38994965325;9476.384035037701;506.2861365474663;547.17923115327;552.9825121775951;557.1892895836548;583.7460704593516;3632.1101330173747;3856.9421458678144;3905.9804700976315;4010.258102251093;4048.684177642278;58241.4175858236;59541.70229148826;60589;60839;61732;46624.53375466202;49176.7541162299;50947.49052509502;51212;51519.48480515222;46371.840703981994;47328.763356183;48306.75846620815;48597.757011214715;48639.270410943864;8387.538685372363;8537.53043582609;8669.349798765244;8701.695440659547;8737.606807693543;35068;35097.82451087728;35123;35609.28781424409;35743.28513429769;39147.41278880876;39757.40363894486;40816.59183408128;43566.78216608897;43719.344209837516;10473.633422830164;10572.259941804308;10924.696841159928;10991.505382257657;11312.717182070184;12158.696032599255;12183.451744671689;12232;13082;13394.665133371744;10466.738331541772;10646.467676616294;10745.838812417664;11285.040771534512;11312.6040588579;10309.845352319571;10386.636467723594;10750.623728169476;10830.512626931964;10916.890831091905;11413;11635.709107272385;12176.512939482676;12361.381930903599;12367.69080772988;9433.198178154933;9635.277354198322;10190.847137293094;10418.73953151147;10482.161427085968;9485.620575176916;9803.607855685692;9812.116909478182;9822.312438129262;9846.359986600848 07:53:35 INFO - PROCESS | 3572 | __end_tp_report 07:53:35 INFO - PROCESS | 3572 | __start_cc_report 07:53:35 INFO - PROCESS | 3572 | _x_x_mozilla_cycle_collect,2550 07:53:35 INFO - PROCESS | 3572 | __end_cc_report 07:53:35 INFO - PROCESS | 3572 | __startTimestamp1481385215136__endTimestamp 07:53:35 INFO - PROCESS | 3572 | 07:53:35 INFO - PROCESS | 3572 | ------- Summary: start ------- 07:53:35 INFO - PROCESS | 3572 | Number of tests: 6 07:53:35 INFO - PROCESS | 3572 | 07:53:35 INFO - PROCESS | 3572 | [#0] dojo.html Cycles:165 Average:4499.01 Median:4626.98 stddev:470.12 (10.2%) stddev-sans-first:445.95 07:53:35 INFO - PROCESS | 3572 | Values: 2547.9 2573.2 2580.9 2582.0 2593.0 4434.5 4484.5 4497.5 4515.8 4519.6 4510.0 4525.3 4538.2 4556.1 4569.2 4164.9 4194.7 4217.5 4218.1 4282.1 3902.5 4272.7 4273.1 4292.5 4343.8 4120.7 4138.4 4150.4 4286.4 4301.9 4179.4 4183.1 4184.4 4186.6 4198.0 4188.1 4203.1 4225.2 4231.0 4249.8 4538.0 4540.0 4552.8 4571.4 4587.5 4759.6 4804.8 4806.3 4843.2 4851.8 4871.6 4880.9 4888.8 4890.0 4893.3 4553.9 4566.3 4566.5 4568.4 4574.2 4937.3 4973.1 4977.3 4979.8 4989.8 4698.5 4786.2 4797.7 4799.5 4804.9 4823.2 4895.8 4899.7 4907.4 4908.4 4785.4 4799.8 4815.9 4816.1 4856.8 4785.5 4790.8 4792.1 4796.1 4839.6 3913.3 3938.5 3939.8 3968.5 3974.1 3520.1 3520.9 3553.0 3555.7 3559.1 4238.7 4248.6 4256.7 4258.9 4279.4 4815.9 4852.6 4870.0 4875.5 4877.1 4264.6 4295.7 4298.6 4320.7 4324.5 4355.9 4358.8 4361.8 4388.9 4396.9 4538.5 4579.6 4645.5 4649.2 4686.5 4884.3 4886.5 4899.9 4900.0 4902.2 4560.1 4614.6 4624.9 4627.0 4629.7 4794.0 4795.0 4798.1 4798.1 4802.6 4821.2 4861.0 4869.5 4870.6 4870.8 4709.5 4739.1 4741.1 4744.1 4746.1 4716.6 4735.2 4738.8 4745.5 4750.9 4680.7 4737.5 4740.4 4746.2 4793.8 4823.7 4831.3 4839.5 4842.4 4880.5 4593.1 4624.3 4646.8 4655.3 4659.6 07:53:35 INFO - PROCESS | 3572 | 07:53:35 INFO - PROCESS | 3572 | [#1] ext.html Cycles:180 Average:44177.05 Median:35049.15 stddev:76265.66 (217.6%) stddev-sans-first:76409.18 07:53:35 INFO - PROCESS | 3572 | Values: 525.5 533.5 546.1 548.1 561.3 26668.6 29391.7 29507.1 35479.5 37271.0 37709.4 38042.8 38065.0 38159.0 38190.2 7296.2 7470.6 7473.3 7475.5 7484.1 7231.3 7401.7 7414.0 9076.5 9338.0 9322.6 9389.4 9405.2 9406.7 9419.9 9567.5 9593.1 9595.4 9685.2 9686.6 9075.6 9163.2 9164.3 9172.3 9172.4 34900.7 35067.6 35305.3 35336.5 35701.5 2930.4 3022.7 3082.5 3292.9 3301.9 26659.2 26859.7 27068.2 27533.6 27711.3 3248.5 3301.1 3331.5 3379.0 3402.0 184749.0 228121.0 230461.0 230648.0 230817.0 51664.0 52490.2 52629.5 52631.7 52638.7 55028.2 55855.4 55956.7 55959.2 56019.0 12805.7 13032.2 13041.0 13044.9 13048.2 8767.3 9391.0 9452.3 9463.5 9470.6 15418.5 18149.9 18687.9 18725.7 19380.7 6780.5 7257.8 7381.5 7383.7 7431.4 805.8 901.4 918.5 951.7 985.8 26209.3 27099.7 28781.9 30348.0 30868.8 916.0 916.4 938.8 953.4 953.9 13829.6 14501.3 14526.0 14541.8 14663.7 315418.0 323094.0 323922.0 324398.0 325070.0 46011.0 46390.0 46465.8 46597.0 46603.3 1168.6 1196.9 1205.5 1209.6 1211.9 24215.4 24262.4 26035.5 26469.0 28462.0 39774.4 40354.6 40400.0 40433.2 40480.6 313553.0 317686.0 318162.0 318683.0 318710.0 32032.7 32233.0 33044.0 33240.2 35968.8 30732.0 35030.6 36050.3 42463.0 44979.3 34636.0 35246.8 35325.5 35534.3 35612.3 34382.8 34433.7 34811.8 35004.5 35027.6 33981.5 34343.1 34573.1 34789.7 34790.3 30280.8 31574.6 31698.4 31796.0 32513.2 24856.0 25040.1 25103.9 25123.5 25461.6 07:53:35 INFO - PROCESS | 3572 | 07:53:35 INFO - PROCESS | 3572 | [#2] jquery.html Cycles:180 Average:22145.42 Median:4909.35 stddev:56188.95 (1144.5%) stddev-sans-first:56322.70 07:53:35 INFO - PROCESS | 3572 | Values: 332.6 343.6 361.8 366.7 381.8 15228.5 15973.3 16655.0 16854.5 16871.0 15743.8 16087.4 16211.3 16315.0 16375.8 4412.7 4877.0 4901.1 4905.6 4913.1 3584.5 3778.8 4759.0 4849.2 4851.6 5326.1 5572.2 5599.8 5690.5 5691.9 5453.8 5576.4 5596.8 5662.4 5676.5 4922.6 4925.1 4927.9 4928.5 4938.5 17708.6 18340.0 18463.5 18610.2 19511.5 1761.0 1827.1 1908.3 2029.9 2306.4 8779.2 9212.2 9748.4 10109.9 12919.5 1639.3 1685.2 1707.4 1715.8 1752.7 58694.9 59468.4 61892.7 62414.4 63726.0 9250.7 9432.2 9491.4 9550.1 9896.4 12990.1 13068.9 13108.7 13133.9 13146.4 6486.3 6663.7 6716.6 6890.0 6909.0 6201.8 6209.4 6349.6 6377.6 6378.2 3856.2 3883.0 4205.0 4229.4 4288.6 1668.2 1722.7 1769.5 1775.3 1787.5 684.3 818.6 862.5 914.5 954.9 14734.2 15774.2 16115.4 16151.9 16833.0 802.1 807.4 811.6 817.6 822.9 8841.2 9414.8 9450.3 9465.7 9646.6 332137.0 335908.0 336906.0 338344.0 352209.0 74562.6 74791.0 74831.3 75367.0 78146.6 855.4 883.1 902.0 903.7 904.2 14537.5 14723.2 15274.4 15463.8 15506.8 34691.0 34728.7 34797.1 35599.0 36322.6 45484.5 47702.3 47748.7 48548.5 50404.2 7183.0 7268.4 7364.5 7444.6 7512.2 8200.6 10421.7 10953.2 11050.9 11760.1 8929.7 9108.5 9734.9 9804.5 10247.2 9890.5 9928.8 10130.6 10153.5 10169.5 8951.9 9445.3 9586.5 9757.1 10228.2 6382.5 6617.1 6655.1 6923.3 7459.2 7225.3 9725.6 9915.7 10037.9 10309.6 07:53:35 INFO - PROCESS | 3572 | 07:53:35 INFO - PROCESS | 3572 | [#3] mootools.html Cycles:180 Average:4495.35 Median:5837.44 stddev:2391.46 (41.0%) stddev-sans-first:2384.20 07:53:35 INFO - PROCESS | 3572 | Values: 1056.0 1073.9 1123.2 1447.8 1624.9 6467.6 6745.5 6756.1 6796.0 6879.7 6063.2 6226.1 6533.8 6730.3 6730.4 1964.6 2019.5 2022.0 2022.7 2024.0 1933.0 2032.4 2033.1 2055.2 2057.9 1729.8 1788.7 1887.8 1963.5 2001.2 2001.2 2001.4 2001.9 2001.9 2002.2 2003.0 2013.6 2025.4 2032.5 2034.3 6661.4 6734.2 6754.8 6785.1 6847.4 3995.9 4120.6 4121.9 4125.3 4132.7 2543.7 2655.6 2678.5 2694.4 2719.0 817.1 862.5 874.9 888.4 910.9 8702.3 8756.5 8762.5 8767.2 8777.5 3549.3 3645.0 3692.6 3728.5 3730.7 7719.3 7782.4 7791.0 7802.9 7805.8 3958.8 3962.5 3964.5 4007.6 4008.8 3600.8 3710.8 3748.6 3803.5 3806.5 3052.2 3113.8 3122.7 3139.7 3202.4 960.1 968.1 973.6 975.8 979.2 729.4 738.9 773.5 779.3 861.7 4789.4 4799.7 4880.4 4971.6 5134.2 800.9 872.2 877.3 883.6 885.6 3272.2 3329.3 3362.3 3430.2 3513.8 7712.2 7918.7 7955.7 8140.5 8197.4 8149.2 8168.8 8174.0 8198.1 8201.3 6076.5 6160.6 6265.3 6277.3 6285.5 4739.5 4918.5 4923.2 4990.8 5158.8 7336.4 7354.0 7471.8 7546.7 7651.0 7332.6 7432.7 7443.0 7487.9 7604.4 5805.9 5919.9 5936.4 5978.2 6054.8 6501.7 6506.1 6532.5 6537.3 6584.2 5957.6 6028.5 6032.3 6103.7 6119.6 5868.9 5927.9 5927.9 5972.4 6037.9 5579.4 5651.4 5665.5 5712.6 5722.1 4256.2 4285.9 4323.8 4360.0 4495.3 4298.0 4335.6 4355.7 4442.5 4483.0 07:53:35 INFO - PROCESS | 3572 | 07:53:35 INFO - PROCESS | 3572 | [#4] prototype.html Cycles:180 Average:4012.70 Median:4584.31 stddev:1138.44 (24.8%) stddev-sans-first:1107.56 07:53:35 INFO - PROCESS | 3572 | Values: 329.2 337.8 338.8 349.4 352.9 4640.8 4660.2 4662.5 4667.8 4692.6 4582.4 4591.4 4600.9 4613.7 4652.3 3554.4 3651.4 3661.7 3716.5 3733.5 3741.8 3751.8 3752.5 3767.6 3773.9 3716.6 3735.2 3736.7 3738.4 3739.8 3547.3 3624.6 3640.6 3730.4 3755.4 3357.0 3357.9 3362.9 3364.5 3365.3 4500.2 4527.5 4528.4 4532.5 4537.0 4095.2 4241.8 4243.6 4248.3 4253.5 4804.4 4842.0 4849.5 4854.7 4865.5 3655.2 3660.6 3661.4 3663.9 3668.9 5053.2 5070.8 5071.6 5071.8 5078.4 3305.2 3491.7 3515.9 3531.3 3532.4 3553.6 3553.9 3570.2 3575.5 3577.5 4032.0 4047.0 4047.2 4047.7 4057.1 4732.0 4805.8 4821.1 4841.8 4864.2 1206.2 1212.0 1216.8 1218.0 1218.7 803.5 821.8 828.4 828.6 830.7 4200.6 4228.0 4279.4 4306.7 4338.5 4967.2 4995.9 5012.8 5017.9 5027.7 4362.3 4363.2 4364.8 4365.0 4372.0 2520.9 2578.3 2580.9 2591.2 2601.7 4543.3 4617.2 4622.1 4623.0 4637.6 4988.4 5000.7 5001.9 5009.4 5010.9 4467.6 4543.4 4587.7 4587.8 4642.4 4817.9 4842.2 4847.5 4864.6 4869.4 4744.0 4744.2 4786.2 4787.7 4790.9 4412.9 4595.4 4630.3 4635.6 4649.7 3445.3 3452.0 3453.2 3461.4 3463.8 4877.5 4882.2 4885.5 4897.8 4903.3 4466.0 4724.0 4743.9 4757.7 4783.7 4714.5 4726.7 4739.5 4743.5 4748.4 4672.5 4676.3 4678.7 4698.9 4705.1 4626.2 4712.6 4772.0 4788.1 4800.8 4586.2 4599.8 4611.7 4644.0 4648.7 07:53:35 INFO - PROCESS | 3572 | 07:53:35 INFO - PROCESS | 3572 | [#5] yui.html Cycles:180 Average:14226.44 Median:42191.69 stddev:17162.83 (40.7%) stddev-sans-first:17180.69 07:53:35 INFO - PROCESS | 3572 | Values: 647.4 648.7 662.4 669.2 727.7 12241.5 13307.0 13312.3 13317.9 13320.7 12464.6 12554.4 12562.3 12602.1 12659.6 606.0 621.4 722.1 731.2 743.1 742.2 758.7 759.1 759.1 760.4 790.8 792.0 793.2 793.3 793.3 635.6 640.9 768.1 783.9 785.5 575.2 575.4 575.7 575.8 576.1 12322.4 12325.8 12333.9 12360.6 12376.8 12852.4 12984.2 12985.2 13005.2 13216.5 11701.5 11869.1 11966.8 11980.6 12256.2 3945.4 3959.3 4021.5 4066.1 4074.4 61829.0 63163.0 63299.1 64990.4 65822.7 10117.7 10174.2 10175.6 10235.0 10476.4 19455.9 19493.6 19527.8 19533.2 19607.7 6586.3 6624.0 6754.4 6779.7 6840.2 3552.7 3573.9 3625.8 3644.7 3741.6 2635.9 2695.5 2709.1 2724.8 2738.9 460.8 462.9 468.2 469.0 481.5 499.5 537.2 537.8 542.6 556.3 7284.7 8792.6 9302.5 9385.4 9476.4 506.3 547.2 553.0 557.2 583.7 3632.1 3856.9 3906.0 4010.3 4048.7 58241.4 59541.7 60589.0 60839.0 61732.0 46624.5 49176.8 50947.5 51212.0 51519.5 46371.8 47328.8 48306.8 48597.8 48639.3 8387.5 8537.5 8669.3 8701.7 8737.6 35068.0 35097.8 35123.0 35609.3 35743.3 39147.4 39757.4 40816.6 43566.8 43719.3 10473.6 10572.3 10924.7 10991.5 11312.7 12158.7 12183.5 12232.0 13082.0 13394.7 10466.7 10646.5 10745.8 11285.0 11312.6 10309.8 10386.6 10750.6 10830.5 10916.9 11413.0 11635.7 12176.5 12361.4 12367.7 9433.2 9635.3 10190.8 10418.7 10482.2 9485.6 9803.6 9812.1 9822.3 9846.4 07:53:35 INFO - PROCESS | 3572 | -------- Summary: end -------- 07:53:35 INFO - PROCESS | 3572 | 07:53:36 INFO - TEST-INFO | 3572: exit 0 07:53:36 INFO - TEST-OK | dromaeo_css | took 1123979ms 07:53:36 INFO - TEST-START | kraken 07:53:36 INFO - operating with platform_type : linux_ 07:53:36 INFO - Initialising browser for kraken test... 07:53:36 INFO - TEST-INFO | started process 3912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpELjEQ1/profile http://localhost:47215/getInfo.html) 07:53:40 INFO - PROCESS | 3912 | __metrics Screen width/height:1600/1200 07:53:40 INFO - PROCESS | 3912 | colorDepth:24 07:53:40 INFO - PROCESS | 3912 | Browser inner width/height: 1024/697 07:53:40 INFO - PROCESS | 3912 | __metrics 07:53:40 INFO - PROCESS | 3912 | 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" 07:53:40 INFO - PROCESS | 3912 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:53:41 INFO - PROCESS | 3912 | console.error: PushService: 07:53:41 INFO - PROCESS | 3912 | stateChangeProcessEnqueue: Error transitioning state 07:53:41 INFO - PROCESS | 3912 | UnknownError 07:53:42 INFO - TEST-INFO | 3912: exit 0 07:53:42 INFO - Browser initialized. 07:53:42 INFO - Running cycle 1/1 for kraken test... 07:53:42 INFO - TEST-INFO | started process 3995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpELjEQ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:54 INFO - PROCESS | 3995 | RSS: Main: 173551616 07:53:54 INFO - PROCESS | 3995 | 07:53:57 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47215/tests/kraken/driver.html?testName=audio-beat-detection) 07:53:58 INFO - PROCESS | 3995 | RSS: Main: 235986944 07:53:58 INFO - PROCESS | 3995 | 07:54:01 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47215/tests/kraken/driver.html?testName=audio-dft) 07:54:01 INFO - PROCESS | 3995 | RSS: Main: 217939968 07:54:01 INFO - PROCESS | 3995 | 07:54:04 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47215/tests/kraken/driver.html?testName=audio-fft) 07:54:05 INFO - PROCESS | 3995 | RSS: Main: 300527616 07:54:05 INFO - PROCESS | 3995 | 07:54:07 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47215/tests/kraken/driver.html?testName=audio-oscillator) 07:54:08 INFO - PROCESS | 3995 | RSS: Main: 212180992 07:54:08 INFO - PROCESS | 3995 | 07:54:10 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47215/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:54:11 INFO - PROCESS | 3995 | RSS: Main: 213929984 07:54:11 INFO - PROCESS | 3995 | 07:54:14 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47215/tests/kraken/driver.html?testName=imaging-darkroom) 07:54:15 INFO - PROCESS | 3995 | RSS: Main: 253448192 07:54:15 INFO - PROCESS | 3995 | 07:54:18 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47215/tests/kraken/driver.html?testName=imaging-desaturate) 07:54:19 INFO - PROCESS | 3995 | RSS: Main: 253579264 07:54:19 INFO - PROCESS | 3995 | 07:54:21 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47215/tests/kraken/driver.html?testName=json-parse-financial) 07:54:22 INFO - PROCESS | 3995 | RSS: Main: 252563456 07:54:22 INFO - PROCESS | 3995 | 07:54:24 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47215/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:54:24 INFO - PROCESS | 3995 | RSS: Main: 215011328 07:54:24 INFO - PROCESS | 3995 | 07:54:26 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47215/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:54:27 INFO - PROCESS | 3995 | RSS: Main: 222154752 07:54:27 INFO - PROCESS | 3995 | 07:54:29 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47215/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:54:30 INFO - PROCESS | 3995 | RSS: Main: 226840576 07:54:30 INFO - PROCESS | 3995 | 07:54:33 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:54:33 INFO - PROCESS | 3995 | RSS: Main: 225124352 07:54:33 INFO - PROCESS | 3995 | 07:54:37 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:54:37 INFO - PROCESS | 3995 | RSS: Main: 227954688 07:54:37 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:47215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47215/tests/kraken/driver.html?testName=ai-astar) 07:54:39 INFO - PROCESS | 3995 | RSS: Main: 281403392 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | __start_tp_report 07:54:39 INFO - PROCESS | 3995 | _x_x_mozilla_page_load 07:54:39 INFO - PROCESS | 3995 | _x_x_mozilla_page_load_details 07:54:39 INFO - PROCESS | 3995 | |i|pagename|runs| 07:54:39 INFO - PROCESS | 3995 | |0;ai-astar;108;118;115;114;115;117;116;117;116;114 07:54:39 INFO - PROCESS | 3995 | |1;audio-beat-detection;156;138;133;167;135;138;141;128;153;134 07:54:39 INFO - PROCESS | 3995 | |2;audio-dft;163;164;162;162;162;164;164;163;164;163 07:54:39 INFO - PROCESS | 3995 | |3;audio-fft;76;77;76;107;77;77;77;77;96;76 07:54:39 INFO - PROCESS | 3995 | |4;audio-oscillator;84;85;109;85;86;85;107;85;85;112 07:54:39 INFO - PROCESS | 3995 | |5;imaging-gaussian-blur;127;126;127;127;127;127;127;126;127;126 07:54:39 INFO - PROCESS | 3995 | |6;imaging-darkroom;146;147;145;147;147;147;146;148;147;147 07:54:39 INFO - PROCESS | 3995 | |7;imaging-desaturate;99;95;95;95;95;95;95;95;95;95 07:54:39 INFO - PROCESS | 3995 | |8;json-parse-financial;64;65;65;66;65;66;65;66;66;66 07:54:39 INFO - PROCESS | 3995 | |9;json-stringify-tinderbox;66;67;66;65;68;66;66;67;66;67 07:54:39 INFO - PROCESS | 3995 | |10;stanford-crypto-aes;90;89;94;89;95;90;91;94;129;92 07:54:39 INFO - PROCESS | 3995 | |11;stanford-crypto-ccm;141;137;139;140;153;139;141;139;160;139 07:54:39 INFO - PROCESS | 3995 | |12;stanford-crypto-pbkdf2;181;184;181;183;182;182;196;181;181;188 07:54:39 INFO - PROCESS | 3995 | |13;stanford-crypto-sha256-iterative;76;69;67;69;70;69;70;69;76;70 07:54:39 INFO - PROCESS | 3995 | __end_tp_report 07:54:39 INFO - PROCESS | 3995 | __start_cc_report 07:54:39 INFO - PROCESS | 3995 | _x_x_mozilla_cycle_collect,1939 07:54:39 INFO - PROCESS | 3995 | __end_cc_report 07:54:39 INFO - PROCESS | 3995 | __startTimestamp1481385279696__endTimestamp 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | ------- Summary: start ------- 07:54:39 INFO - PROCESS | 3995 | Number of tests: 14 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#0] ai-astar Cycles:10 Average:115.00 Median:116.00 stddev:2.79 (2.4%) stddev-sans-first:1.39 07:54:39 INFO - PROCESS | 3995 | Values: 108.0 118.0 115.0 114.0 115.0 117.0 116.0 117.0 116.0 114.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:139.50 stddev:12.31 (8.8%) stddev-sans-first:12.02 07:54:39 INFO - PROCESS | 3995 | Values: 156.0 138.0 133.0 167.0 135.0 138.0 141.0 128.0 153.0 134.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 07:54:39 INFO - PROCESS | 3995 | Values: 163.0 164.0 162.0 162.0 162.0 164.0 164.0 163.0 164.0 163.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.00 stddev:10.81 (14.0%) stddev-sans-first:11.28 07:54:39 INFO - PROCESS | 3995 | Values: 76.0 77.0 76.0 107.0 77.0 77.0 77.0 77.0 96.0 76.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:85.00 stddev:11.82 (13.9%) stddev-sans-first:12.15 07:54:39 INFO - PROCESS | 3995 | Values: 84.0 85.0 109.0 85.0 86.0 85.0 107.0 85.0 85.0 112.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#5] imaging-gaussian-blur Cycles:10 Average:126.70 Median:127.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:54:39 INFO - PROCESS | 3995 | Values: 127.0 126.0 127.0 127.0 127.0 127.0 127.0 126.0 127.0 126.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 07:54:39 INFO - PROCESS | 3995 | Values: 146.0 147.0 145.0 147.0 147.0 147.0 146.0 148.0 147.0 147.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:0.00 07:54:39 INFO - PROCESS | 3995 | Values: 99.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 07:54:39 INFO - PROCESS | 3995 | Values: 64.0 65.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 66.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 07:54:39 INFO - PROCESS | 3995 | Values: 66.0 67.0 66.0 65.0 68.0 66.0 66.0 67.0 66.0 67.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#10] stanford-crypto-aes Cycles:10 Average:95.30 Median:91.50 stddev:12.04 (13.2%) stddev-sans-first:12.61 07:54:39 INFO - PROCESS | 3995 | Values: 90.0 89.0 94.0 89.0 95.0 90.0 91.0 94.0 129.0 92.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:140.50 stddev:7.50 (5.3%) stddev-sans-first:7.92 07:54:39 INFO - PROCESS | 3995 | Values: 141.0 137.0 139.0 140.0 153.0 139.0 141.0 139.0 160.0 139.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:182.50 stddev:4.77 (2.6%) stddev-sans-first:4.94 07:54:39 INFO - PROCESS | 3995 | Values: 181.0 184.0 181.0 183.0 182.0 182.0 196.0 181.0 181.0 188.0 07:54:39 INFO - PROCESS | 3995 | 07:54:39 INFO - PROCESS | 3995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:3.03 (4.3%) stddev-sans-first:2.47 07:54:39 INFO - PROCESS | 3995 | Values: 76.0 69.0 67.0 69.0 70.0 69.0 70.0 69.0 76.0 70.0 07:54:39 INFO - PROCESS | 3995 | -------- Summary: end -------- 07:54:39 INFO - PROCESS | 3995 | 07:54:41 INFO - TEST-INFO | 3995: exit 0 07:54:41 INFO - TEST-OK | kraken | took 64999ms 07:54:41 INFO - SUITE-END | took 1188s 07:54:41 INFO - Completed test suite (00:19:49) 07:54:41 INFO - javascript benchmark 07:54:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2547.9490410191797, 2573.2151693733404, 2580.896764129435, 2582.0317380982133, 2593.0016943476758, 4434.534373890743, 4484.484284307306, 4497.527759585246, 4515.796789144488, 4519.638428925687, 4509.977450112745, 4525.34382514536, 4538.205813982557, 4556.111558246143, 4569.177548041352, 4164.875053748392, 4194.727342722713, 4217.472815898012, 4218.147006910591, 4282.14357128574, 3902.5443012437654, 4272.658187345005, 4273.145370925828, 4292.549282325358, 4343.826246950118, 4120.7321524100835, 4138.379243113527, 4150.439690641755, 4286.421333120051, 4301.870943871689, 4179.373094035888, 4183.079722461053, 4184.4141820145205, 4186.5604111568155, 4198.03445207604, 4188.057687020427, 4203.096334288142, 4225.239456897757, 4231.048014196812, 4249.830006799724, 4538.047010127877, 4540.046590216059, 4552.817887284505, 4571.428571428572, 4587.541245875419, 4759.643026773006, 4804.807807687724, 4806.279058141272, 4843.22508398658, 4851.805927762885, 4871.634627402924, 4880.853574392739, 4888.780004899788, 4889.975550122263, 4893.339399181136, 4553.908921821579, 4566.315052742115, 4566.543345665407, 4568.428946381702, 4574.222382195035, 4937.284093806378, 4973.05511952735, 4977.278294647256, 4979.800807967641, 4989.800407983713, 4698.506656800987, 4786.1624215762795, 4797.712137271775, 4799.496052914464, 4804.855854324376, 4823.2282834746275, 4895.828645997373, 4899.681520701143, 4907.386576677915, 4908.435529914105, 4785.425748910153, 4799.832005879777, 4815.855524334275, 4816.109019831342, 4856.78144483492, 4785.521447855187, 4790.808367665254, 4792.065547218259, 4796.088743138793, 4839.588634966068, 3913.295606790805, 3938.547067087264, 3939.803009849496, 3968.4840970673627, 3974.0859602291634, 3520.1023738946915, 3520.859165633346, 3552.9644703552635, 3555.662212089899, 3559.128013636624, 4238.660907127422, 4248.553901840324, 4256.7445953242905, 4258.893527661771, 4279.379489973936, 4815.855524334275, 4852.56326930578, 4869.9513004870205, 4875.463698993108, 4877.12211801879, 4264.616184543344, 4295.699301048959, 4298.591633794785, 4320.740755554677, 4324.481062272547, 4355.912881742347, 4358.760268185217, 4361.847335343247, 4388.890277743082, 4396.9120617588105, 4538.455385353646, 4579.633629309581, 4645.488996210346, 4649.163150632919, 4686.461056978491, 4884.291777692144, 4886.511348865085, 4899.877503062452, 4900.019996000743, 4902.166631672696, 4560.065186636798, 4614.607758340444, 4624.861254162381, 4626.976865115787, 4629.699069560468, 4793.976030119827, 4794.976025119852, 4798.088363210979, 4798.1123492154065, 4802.615790736802, 4821.228603423436, 4860.95139048605, 4869.464358920445, 4870.610351171827, 4870.805167793249, 4709.481956984798, 4739.146953548395, 4741.122892264942, 4744.098621261949, 4746.121967436035, 4716.575508204278, 4735.171345014677, 4738.786754596121, 4745.47799742035, 4750.857474275777, 4680.695754775928, 4737.455192652889, 4740.3837501124635, 4746.216874215854, 4793.832215872428, 4823.686460380064, 4831.323614693875, 4839.491853355347, 4842.443119041355, 4880.463149053672, 4593.104344652761, 4624.28323609841, 4646.8141274348645, 4655.2784318430695, 4659.627229821538], "value": 4469.159341596344, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.4823998361616, 533.4851867947431, 546.0825812634772, 548.106586264389, 561.3011800308616, 26668.599971000425, 29391.706082939192, 29507.114786556413, 35479.4678079829, 37271.0, 37709.43435848458, 38042.80978595103, 38065.0, 38159.0, 38190.23619527615, 7296.197418283985, 7470.626468676572, 7473.327400533951, 7475.514091584029, 7484.064491938508, 7231.313025262618, 7401.666924988388, 7414.0, 9076.503961410632, 9337.953310233439, 9322.62709491623, 9389.436633801959, 9405.200557952583, 9406.670766523173, 9419.905800941971, 9567.473788941605, 9593.136617704371, 9595.376300540442, 9685.176759975411, 9686.612535498607, 9075.636974521078, 9163.22112620428, 9164.312676549285, 9172.312076594282, 9172.357934944557, 34900.65099349025, 35067.649323506696, 35305.293894121976, 35336.46995295073, 35701.46447803285, 2930.428566429547, 3022.7128422799797, 3082.537619357092, 3292.917677058069, 3301.851416686231, 26659.20022399331, 26859.731402685917, 27068.1879543614, 27533.586996195074, 27711.307217319525, 3248.545203671488, 3301.125201821495, 3331.53358529806, 3378.9662103378896, 3402.030421329909, 184749.0, 228121.0, 230461.0, 230648.0, 230817.0, 51664.0, 52490.21264681033, 52629.473705263226, 52631.73684131555, 52638.73680631573, 55028.174577381375, 55855.441445585835, 55956.72021639866, 55959.160612590844, 56019.0, 12805.743885122245, 13032.218066916015, 13041.0, 13044.869551304366, 13048.151870128411, 8767.342449316327, 9391.0, 9452.291078169164, 9463.479508626953, 9470.621175152917, 15418.537443876701, 18149.909250453664, 18687.906560467112, 18725.719114213298, 19380.70928936067, 6780.525363224527, 7257.818554536073, 7381.520201186906, 7383.704651813868, 7431.405487560982, 805.8388322335556, 901.4095767272447, 918.4902379179485, 951.7097285328041, 985.763416779982, 26209.344766380993, 27099.729002710115, 28781.85609071941, 30348.0, 30868.845655772027, 915.9514943947767, 916.3768637326682, 938.8357037518407, 953.4231789767091, 953.8903026151943, 13829.585112446643, 14501.347439365254, 14525.983181177427, 14541.78187327191, 14663.706725865422, 315418.0, 323094.0, 323922.0, 324398.0, 325070.0, 46011.0, 46390.0, 46465.7676711621, 46597.0, 46603.30095048577, 1168.6435637130587, 1196.9341686207342, 1205.5177928828539, 1209.6431552691802, 1211.854577450694, 24215.394615134763, 24262.393440164138, 26035.479290414463, 26469.0, 28462.0, 39774.403383949844, 40354.596454036255, 40400.0, 40433.191336172524, 40480.59519404768, 313553.0, 317686.0, 318162.0, 318683.0, 318710.0, 32032.67967320297, 32233.0, 33044.0, 33240.1689957753, 35968.820155899055, 30732.0, 35030.64969350376, 36050.27899442049, 42463.0, 44979.32531011972, 34636.0, 35246.823765881, 35325.47011794877, 35534.28931421409, 35612.28775424529, 34382.82808586041, 34433.655663443045, 34811.825940870134, 35004.47493287552, 35027.649723502436, 33981.49027764536, 34343.13137372486, 34573.13567160841, 34789.65210347864, 34790.30419391648, 30280.84859575688, 31574.60472098105, 31698.366032679678, 31796.0, 32513.187170320933, 24856.0, 25040.123595674064, 25103.87448062748, 25123.467898346196, 25461.618075728507], "value": 17190.514944572522, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.5610194543201, 343.6305971081089, 361.75400727505297, 366.72678854253576, 381.81481981239097, 15228.54314370568, 15973.281202345894, 16655.0, 16854.494365169034, 16871.0, 15743.763843542356, 16087.436939707113, 16211.270492827822, 16315.021098734085, 16375.83624163758, 4412.713173643711, 4877.0, 4901.1177987962155, 4905.607551395898, 4913.091078150535, 3584.4623306503972, 3778.792166430845, 4758.976205118969, 4849.224124140138, 4851.59303801897, 5326.147816349385, 5572.219889215513, 5599.776008959637, 5690.459406356389, 5691.8577035574235, 5453.754581043862, 5576.442355764431, 5596.804111856066, 5662.433756624325, 5676.460736230072, 4922.581580565657, 4925.064237794843, 4927.926081108786, 4928.48250933654, 4938.4814594467425, 17708.557286067822, 18340.0, 18463.538411539685, 18610.16254268561, 19511.512212194666, 1760.9647807043916, 1827.1412436154985, 1908.2557802457052, 2029.9289524866558, 2306.423394151462, 8779.209871111567, 9212.216961558275, 9748.415095094317, 10109.949450252776, 12919.483220671162, 1639.2787173643678, 1685.1658429077563, 1707.4109432245855, 1715.785526809149, 1752.6582316448298, 58694.902290145095, 59468.40531594672, 61892.69053654748, 62414.37585624131, 63726.0441093384, 9250.67622633218, 9432.151106400319, 9491.430514169035, 9550.087223396931, 9896.356736812084, 12990.090693651353, 13068.869311306955, 13108.672283192996, 13133.934330328479, 13146.4084116215, 6486.286508484063, 6663.733450662016, 6716.597004179765, 6890.0, 6908.965455172692, 6201.782937597162, 6209.441150296495, 6349.587276826992, 6377.585456945284, 6378.234611846516, 3856.151646637735, 3883.0, 4204.957950420457, 4229.407882896397, 4288.571142885687, 1668.1909274002098, 1722.6985277576625, 1769.51338381946, 1775.2987569909812, 1787.4548262779977, 684.260998122027, 818.6111596991501, 862.4643547968951, 914.4513292024732, 954.9331546791797, 14734.189619570812, 15774.211289435712, 16115.435959741353, 16151.919240403959, 16833.0, 802.0856223904754, 807.3984881263497, 811.5536454949754, 817.5952903312898, 822.8930239068883, 8841.248493877963, 9414.764630884145, 9450.338476306593, 9465.716028519155, 9646.614135434644, 332137.0, 335908.0, 336906.0, 338344.0, 352209.0, 74562.6271868648, 74791.0, 74831.25168748242, 75367.0, 78146.6092669533, 855.3969451536652, 883.077184342351, 902.0213068820273, 903.746950853762, 904.1771987491483, 14537.491187808377, 14723.190224537753, 15274.389024438899, 15463.84536154624, 15506.84493155054, 34691.0, 34728.65271347355, 34797.13007174841, 35599.0, 36322.636773632985, 45484.54515454803, 47702.284465733734, 47748.65759396948, 48548.514514855815, 50404.24393634025, 7182.96408517954, 7268.382187513909, 7364.521306115085, 7444.627768611656, 7512.21121782205, 8200.58997050157, 10421.68734937953, 10953.17851161182, 11050.944745276222, 11760.05919526453, 8929.73210803677, 9108.544572771467, 9734.853977190489, 9804.460754658277, 10247.231457640557, 9890.505474726378, 9928.75178120524, 10130.594776209164, 10153.492325383553, 10169.491525423848, 8951.865722014045, 9445.291603129655, 9586.520673966414, 9757.073078057572, 10228.232882533692, 6382.457491113308, 6617.139771829631, 6655.068290439245, 6923.342282483156, 7459.216782237787, 7225.349718525358, 9725.610975560898, 9915.65295214664, 10037.946015668542, 10309.587616495557], "value": 7783.892201549276, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1056.0, 1073.8603981482408, 1123.1800785426638, 1447.8190226221716, 1624.87813413994, 6467.579607325521, 6745.460363170947, 6756.054152418666, 6796.048553202556, 6879.72481100756, 6063.211782468284, 6226.06609008649, 6533.8039858804195, 6730.326967303267, 6730.394264516192, 1964.6365422396866, 2019.474936516509, 2021.9898900505477, 2022.7168196452508, 2023.979760202394, 1932.9516762080991, 2032.3699653107583, 2033.1460786469645, 2055.219016773624, 2057.9298764642376, 1729.7578339032546, 1788.7227479740661, 1887.7545919030506, 1963.4600484866633, 2001.1995201919203, 2001.2195243854762, 2001.3595649392128, 2001.8698784578955, 2001.909914053871, 2002.2391491233384, 2002.9784809747134, 2013.617412691584, 2025.4328787939253, 2032.5121970727066, 2034.267663641103, 6661.367170118831, 6734.225564060147, 6754.8311292217595, 6785.117934668461, 6847.417969472601, 3995.860144894915, 4120.567340429242, 4121.855735049289, 4125.278076336629, 4132.73137246081, 2543.682039745032, 2655.5751079827137, 2678.450917561895, 2694.380292532709, 2719.048333083425, 817.1379194949326, 862.5299211929513, 874.868769684546, 888.3958907942597, 910.9180173784391, 8702.260307873838, 8756.518391488466, 8762.474251544927, 8767.167119123673, 8777.51723655205, 3549.343371476285, 3645.0, 3692.6122757110115, 3728.5339332583426, 3730.68289195416, 7719.3052625264, 7782.416318776114, 7790.98717166776, 7802.921970780333, 7805.765827025199, 3958.841646334172, 3962.484876965976, 3964.5044369453817, 4007.599240075969, 4008.779517126586, 3600.801955892399, 3710.7588006779474, 3748.55017397914, 3803.4865293185067, 3806.5051543299196, 3052.2064263291704, 3113.7508999280003, 3122.656507784142, 3139.7331226845517, 3202.4235637584993, 960.1454705312277, 968.1141755293827, 973.6494861849728, 975.8292298847673, 979.2117345536911, 729.3873146556917, 738.918718940916, 773.5126870071931, 779.3453499060817, 861.6811779641573, 4789.401324834395, 4799.736014519235, 4880.389951256093, 4971.577415919687, 5134.2298655201275, 800.87986801979, 872.1757938747822, 877.3288434347729, 883.5935469683889, 885.5527958380976, 3272.181954511372, 3329.3174899145615, 3362.277110421271, 3430.1939044324563, 3513.8243087845503, 7712.228777122243, 7918.683252669944, 7955.681772729026, 8140.511569305861, 8197.385196110316, 8149.185081491803, 8168.836623267502, 8173.959130204311, 8198.098209196984, 8201.261886430131, 6076.51387888959, 6160.599561028519, 6265.310815810257, 6277.309495955441, 6285.465735412541, 4739.502352252964, 4918.458969513422, 4923.163062279493, 4990.8253211137435, 5158.767855446589, 7336.37640800538, 7354.0, 7471.775846724607, 7546.6981320748755, 7650.961745191238, 7332.633368331669, 7432.665530051053, 7443.0324057874295, 7487.925120748723, 7604.42966777505, 5805.94194058054, 5919.881602368015, 5936.406359364029, 5978.192943952511, 6054.75780968774, 6501.674916254263, 6506.056621789909, 6532.510061745293, 6537.28089910119, 6584.242812076673, 5957.608174995911, 6028.457438830526, 6032.33644299118, 6103.69481525913, 6119.632822030692, 5868.94131058684, 5927.851803704942, 5927.911081333697, 5972.432618901197, 6037.9094313584455, 5579.386267510652, 5651.406602306699, 5665.49010589049, 5712.6286791358425, 5722.055860782924, 4256.212600668886, 4285.91428171441, 4323.78381080951, 4359.956400436082, 4495.325701144854, 4297.957020429881, 4335.609795118455, 4355.695101342875, 4442.533533979015, 4482.955170448254], "value": 3678.340214425037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.20496999745615, 337.8293961549418, 338.75271052131944, 349.41647448760585, 352.9435290353544, 4640.814367425299, 4660.1844677181525, 4662.463816661081, 4667.789949452274, 4692.583319590413, 4582.404287442636, 4591.428799872066, 4600.861974140773, 4613.723176609397, 4652.255639097745, 3554.36021516127, 3651.379265524867, 3661.7253705972025, 3716.498272733187, 3733.5146430963937, 3741.812909354535, 3751.7936513491745, 3752.4802455005765, 3767.5699174032734, 3773.9056523586855, 3716.646918542734, 3735.234276973214, 3736.7010639148803, 3738.401855703088, 3739.8317075731657, 3547.343741407835, 3624.5831729351066, 3640.6177351378255, 3730.421784623388, 3755.380362240227, 3356.9832150839334, 3357.9160520986925, 3362.9327413451592, 3364.49532570114, 3365.326934613063, 4500.189965806154, 4527.547245275479, 4528.388667529907, 4532.4787649420405, 4536.977315113436, 4095.24238015968, 4241.809118589671, 4243.554426785205, 4248.277792775236, 4253.51084625269, 4804.375431193957, 4842.0, 4849.454036630762, 4854.737768180264, 4865.5134486551415, 3655.2089476156757, 3660.5790334111384, 3661.4324779659196, 3663.8534458621625, 3668.8899333020054, 5053.191489361684, 5070.847874563769, 5071.6053085401445, 5071.797128114871, 5078.390593128848, 3305.2067503799394, 3491.738119641037, 3515.9472607910902, 3531.2584357284745, 3532.434810430319, 3553.626869178751, 3553.9289214216087, 3570.1610121621397, 3575.481555174485, 3577.463380492895, 4032.0, 4047.0169616887515, 4047.170330082326, 4047.736897101679, 4057.1479989202007, 4732.0, 4805.7597120143855, 4821.107335598613, 4841.830535931296, 4864.221724524059, 1206.1858245684127, 1211.9636410907688, 1216.7627312673944, 1217.9817302740466, 1218.695326168458, 803.4978138663336, 821.7945513621595, 828.3828547731978, 828.5691440450931, 830.7424698343533, 4200.5799420058365, 4227.964148783568, 4279.443672322641, 4306.698531102856, 4338.464151716341, 4967.230079337708, 4995.925061124013, 5012.824551140692, 5017.874553136201, 5027.748612569357, 4362.323839804835, 4363.214621368184, 4364.75993820343, 4364.978175109104, 4371.956280437218, 2520.9495810083695, 2578.3296342950966, 2580.903116175618, 2591.2226332100295, 2601.713811480736, 4543.341215523797, 4617.238155704338, 4622.121796858586, 4623.0, 4637.559431853969, 4988.351514303117, 5000.749962501933, 5001.89996200074, 5009.44896061433, 5010.89978200434, 4467.642588592905, 4543.4093567836635, 4587.655925805578, 4587.7706114693465, 4642.419697537808, 4817.855464336076, 4842.201036829025, 4847.515248475124, 4864.610831133572, 4869.391326084239, 4743.9525604744895, 4744.169770290255, 4786.186348320724, 4787.688800227974, 4790.856274311776, 4412.889677758082, 4595.425571803525, 4630.259158534618, 4635.582797548237, 4649.674522783373, 3445.3109378123972, 3452.0, 3453.204333746488, 3461.394256005239, 3463.7575369723877, 4877.487863774394, 4882.194437917846, 4885.462599114166, 4897.804087836446, 4903.33804936329, 4465.9854598145475, 4723.952760472352, 4743.857684269477, 4757.690750101232, 4783.736894470838, 4714.528547145258, 4726.692764970266, 4739.478657347758, 4743.478217396015, 4748.40928289027, 4672.462666793226, 4676.345311656439, 4678.672492925599, 4698.859034228979, 4705.106029854317, 4626.236670949255, 4712.646551508719, 4771.95228047715, 4788.090262850047, 4800.831970881002, 4586.220342541709, 4599.793009314522, 4611.700239484423, 4643.976780116078, 4648.674592778609], "value": 3663.115890475808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.41085612093, 648.701597265258, 662.4071456046838, 669.2136739331286, 727.6870945493438, 12241.510339586417, 13307.0, 13312.267825269606, 13317.933410332947, 13320.7335853283, 12464.563740269092, 12554.43505042273, 12562.309073001004, 12602.054845886549, 12659.55691550796, 605.966671833049, 621.4313902778952, 722.137046229757, 731.2322061835079, 743.1490942870411, 742.1650643026595, 758.7192738686693, 759.0511860174781, 759.1270039454616, 760.4448752410743, 790.8181118342785, 791.9506653683892, 793.1632128104876, 793.2900054451292, 793.3256731777972, 635.5709895820349, 640.9294977552465, 768.0744702633314, 783.902012248469, 785.5286827903269, 575.1602660116193, 575.3987083497755, 575.65748379714, 575.772569834917, 576.0638961687258, 12322.445489952974, 12325.815112773316, 12333.93833030829, 12360.629181124581, 12376.752464950741, 12852.376192820419, 12984.220946743226, 12985.22088674673, 13005.219686818726, 13216.471341146342, 11701.53193872244, 11869.109816763777, 11966.82049769254, 11980.580679676257, 12256.203346782431, 3945.3687410014545, 3959.3467077932105, 4021.4973128358956, 4066.064805094845, 4074.3888416737727, 61829.0, 63163.0, 63299.05051424279, 64990.3500964989, 65822.67088664573, 10117.696469105938, 10174.186065114773, 10175.643852465128, 10234.980198856256, 10476.371417714809, 19455.90272048631, 19493.610127797365, 19527.804721952598, 19533.218671253275, 19607.705884411746, 6586.308437614078, 6624.0, 6754.425873800782, 6779.694913728894, 6840.179178498612, 3552.662497062775, 3573.874914377984, 3625.818709064536, 3644.653757892996, 3741.6258374162367, 2635.907743229016, 2695.5417579011614, 2709.0653724465424, 2724.7547720705234, 2738.87675054623, 460.8133705849136, 462.90973260213934, 468.2461237407771, 468.9624830013591, 481.53772378516317, 499.51796516361156, 537.1834811087203, 537.819830356827, 542.579500886808, 556.3157316500726, 7284.6721897514735, 8792.648294068165, 9302.488363140092, 9385.38994965325, 9476.384035037701, 506.2861365474663, 547.17923115327, 552.9825121775951, 557.1892895836548, 583.7460704593516, 3632.1101330173747, 3856.9421458678144, 3905.9804700976315, 4010.258102251093, 4048.684177642278, 58241.4175858236, 59541.70229148826, 60589.0, 60839.0, 61732.0, 46624.53375466202, 49176.7541162299, 50947.49052509502, 51212.0, 51519.48480515222, 46371.840703981994, 47328.763356183, 48306.75846620815, 48597.757011214715, 48639.270410943864, 8387.538685372363, 8537.53043582609, 8669.349798765244, 8701.695440659547, 8737.606807693543, 35068.0, 35097.82451087728, 35123.0, 35609.28781424409, 35743.28513429769, 39147.41278880876, 39757.40363894486, 40816.59183408128, 43566.78216608897, 43719.344209837516, 10473.633422830164, 10572.259941804308, 10924.696841159928, 10991.505382257657, 11312.717182070184, 12158.696032599255, 12183.451744671689, 12232.0, 13082.0, 13394.665133371744, 10466.738331541772, 10646.467676616294, 10745.838812417664, 11285.040771534512, 11312.6040588579, 10309.845352319571, 10386.636467723594, 10750.623728169476, 10830.512626931964, 10916.890831091905, 11413.0, 11635.709107272385, 12176.512939482676, 12361.381930903599, 12367.69080772988, 9433.198178154933, 9635.277354198322, 10190.847137293094, 10418.73953151147, 10482.161427085968, 9485.620575176916, 9803.607855685692, 9812.116909478182, 9822.312438129262, 9846.359986600848], "value": 6108.627839818138, "unit": "score"}], "name": "dromaeo_css", "value": 6053.904210345346, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 115.0, 114.0, 115.0, 117.0, 116.0, 117.0, 116.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 138.0, 133.0, 167.0, 135.0, 138.0, 141.0, 128.0, 153.0, 134.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 162.0, 162.0, 164.0, 164.0, 163.0, 164.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 107.0, 77.0, 77.0, 77.0, 77.0, 96.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 85.0, 86.0, 85.0, 107.0, 85.0, 85.0, 112.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 127.0, 127.0, 127.0, 127.0, 127.0, 126.0, 127.0, 126.0], "value": 126.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 68.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 94.0, 89.0, 95.0, 90.0, 91.0, 94.0, 129.0, 92.0], "value": 95.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 139.0, 140.0, 153.0, 139.0, 141.0, 139.0, 160.0, 139.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 181.0, 183.0, 182.0, 182.0, 196.0, 181.0, 181.0, 188.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 69.0, 67.0, 69.0, 70.0, 69.0, 70.0, 69.0, 76.0, 70.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1587.4, "alertThreshold": 2.0}]} 07:54:41 INFO - Return code: 0 07:54:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:54:41 INFO - # TBPL SUCCESS # 07:54:41 INFO - Running post-action listener: _resource_record_post_action 07:54:41 INFO - [mozharness: 2016-12-10 15:54:41.518968Z] Finished run-tests step (success) 07:54:41 INFO - Running post-run listener: _resource_record_post_run 07:54:41 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 2428928; Write bytes: 405024768; Read time: 1252; Write time: 293276 07:54:41 INFO - TinderboxPrint: CPU usage
13.2% 07:54:41 INFO - TinderboxPrint: I/O read bytes / time
2,428,928 / 1,252 07:54:41 INFO - TinderboxPrint: I/O write bytes / time
405,024,768 / 293,276 07:54:41 INFO - TinderboxPrint: CPU idle
8,345.8 (86.8%) 07:54:41 INFO - TinderboxPrint: CPU user
1,219.3 (12.7%) 07:54:41 INFO - TinderboxPrint: Swap in / out
0 / 0 07:54:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110440448; Read time: 0; Write time: 66988 07:54:41 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 2424832; Write bytes: 294584320; Read time: 1240; Write time: 226288 07:54:42 INFO - Running post-run listener: _upload_blobber_files 07:54:42 INFO - Blob upload gear active. 07:54:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:54:42 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 07:54:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:54:42 INFO - (blobuploader) - INFO - Open directory for files ... 07:54:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:54:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:54:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:46 INFO - (blobuploader) - INFO - Done attempting. 07:54:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:54:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:54:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:47 INFO - (blobuploader) - INFO - Done attempting. 07:54:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:54:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:54:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:48 INFO - (blobuploader) - INFO - Done attempting. 07:54:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:54:48 INFO - Return code: 0 07:54:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:54:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:54:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9203af24cf4d331b208f368bf3a841b7c43d823ed28943c702f394b4b8721c76bd6518bb9308d35206aa9d9c287ab9274d830ed2119b1bded7eb4842d71a7f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/baa000867aaf1b0a8ccf893541b8e4b7d73b7aaad942d968a0bef368795f7e442d8029c62b70f9df3f9ee9b73cc6a9af679bbdd1222abfba52357bfb921d8d66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f1f9b54cdb1fa9189e8a6e02f9221bfa8467d627c2bcb15e115a8b6e9ace5f8a971c99fd92b9e8a27f73e1c7aa81ff45d7b6fc9f7f42fd5decd99661f63eb56"} 07:54:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:54:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:54:48 INFO - Contents: 07:54:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9203af24cf4d331b208f368bf3a841b7c43d823ed28943c702f394b4b8721c76bd6518bb9308d35206aa9d9c287ab9274d830ed2119b1bded7eb4842d71a7f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/baa000867aaf1b0a8ccf893541b8e4b7d73b7aaad942d968a0bef368795f7e442d8029c62b70f9df3f9ee9b73cc6a9af679bbdd1222abfba52357bfb921d8d66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f1f9b54cdb1fa9189e8a6e02f9221bfa8467d627c2bcb15e115a8b6e9ace5f8a971c99fd92b9e8a27f73e1c7aa81ff45d7b6fc9f7f42fd5decd99661f63eb56"} 07:54:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:54:48 INFO - Copying logs to upload dir... 07:54:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:54:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.573430 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-10 07:54:48.058566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-10 07:54:48.062145) ========= 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=1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9203af24cf4d331b208f368bf3a841b7c43d823ed28943c702f394b4b8721c76bd6518bb9308d35206aa9d9c287ab9274d830ed2119b1bded7eb4842d71a7f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/baa000867aaf1b0a8ccf893541b8e4b7d73b7aaad942d968a0bef368795f7e442d8029c62b70f9df3f9ee9b73cc6a9af679bbdd1222abfba52357bfb921d8d66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f1f9b54cdb1fa9189e8a6e02f9221bfa8467d627c2bcb15e115a8b6e9ace5f8a971c99fd92b9e8a27f73e1c7aa81ff45d7b6fc9f7f42fd5decd99661f63eb56"} build_url:https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011563 build_url: 'https://queue.taskcluster.net/v1/task/M_CNpHUCRxyQhzzthIV1uQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9203af24cf4d331b208f368bf3a841b7c43d823ed28943c702f394b4b8721c76bd6518bb9308d35206aa9d9c287ab9274d830ed2119b1bded7eb4842d71a7f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/baa000867aaf1b0a8ccf893541b8e4b7d73b7aaad942d968a0bef368795f7e442d8029c62b70f9df3f9ee9b73cc6a9af679bbdd1222abfba52357bfb921d8d66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f1f9b54cdb1fa9189e8a6e02f9221bfa8467d627c2bcb15e115a8b6e9ace5f8a971c99fd92b9e8a27f73e1c7aa81ff45d7b6fc9f7f42fd5decd99661f63eb56"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-10 07:54:48.087858) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:54:48.088229) ========= 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=1f5564757af27664ca02d71f000001b0-1481375737.796348-574233296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:54:48.172581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-10 07:54:48.172907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-10 07:54:48.173238) ========= ========= Total master_lag: 0.23 =========