builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1481775383.76 results: success (0) buildid: 20161214183807 builduid: d13bd58dd71545ef8f1eae72468e87ca revision: 3d48c2a8393ab0858920bf9493d3254e6ff120af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:23.761299) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:23.761773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:23.762108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:23.777009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:23.777293) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-14 20:16:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-12-14 20:16:24 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095451 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:23.886561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:23.886891) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014263 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:23.936310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 20:16:23.936659) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3d48c2a8393ab0858920bf9493d3254e6ff120af --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3d48c2a8393ab0858920bf9493d3254e6ff120af --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=d6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-14 20:16:24,485 truncating revision to first 12 chars 2016-12-14 20:16:24,485 Setting DEBUG logging. 2016-12-14 20:16:24,485 attempt 1/10 2016-12-14 20:16:24,485 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3d48c2a8393a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 20:16:25,893 unpacking tar archive at: mozilla-inbound-3d48c2a8393a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.746272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 20:16:25.696481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:25.696813) ========= script_repo_revision: 3d48c2a8393ab0858920bf9493d3254e6ff120af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:25.697201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:25.697467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 20:16:25.724552) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-12-14 20:16:25.724981) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:16:26 INFO - MultiFileLogger online at 20161214 20:16:26 in /builds/slave/test 20:16:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 20:16:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:16:26 INFO - {'append_to_log': False, 20:16:26 INFO - 'base_work_dir': '/builds/slave/test', 20:16:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 20:16:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:16:26 INFO - 'branch': 'Mozilla-Inbound', 20:16:26 INFO - 'buildbot_json_path': 'buildprops.json', 20:16:26 INFO - 'config_files': ('talos/linux_config.py',), 20:16:26 INFO - 'default_actions': ('clobber', 20:16:26 INFO - 'read-buildbot-config', 20:16:26 INFO - 'download-and-extract', 20:16:26 INFO - 'populate-webroot', 20:16:26 INFO - 'create-virtualenv', 20:16:26 INFO - 'install', 20:16:26 INFO - 'run-tests'), 20:16:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:16:26 INFO - 'download_minidump_stackwalk': True, 20:16:26 INFO - 'download_symbols': 'ondemand', 20:16:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:16:26 INFO - 'tooltool.py': '/tools/tooltool.py', 20:16:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:16:26 INFO - '/tools/misc-python/virtualenv.py')}, 20:16:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:16:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:16:26 INFO - 'installer_path': 'installer.exe', 20:16:26 INFO - 'log_level': 'info', 20:16:26 INFO - 'log_name': 'talos', 20:16:26 INFO - 'log_to_console': True, 20:16:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:16:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:16:26 INFO - 'opt_config_files': (), 20:16:26 INFO - 'pip_index': False, 20:16:26 INFO - 'sps_profile': False, 20:16:26 INFO - 'sps_profile_interval': 0, 20:16:26 INFO - 'suite': 'dromaeojs', 20:16:26 INFO - 'system_bits': '32', 20:16:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:16:26 INFO - 'title': 'talos-linux64-ix-034', 20:16:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:16:26 INFO - 'use_talos_json': True, 20:16:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:16:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:16:26 INFO - 'work_dir': 'build'} 20:16:26 INFO - [mozharness: 2016-12-15 04:16:26.376684Z] Running clobber step. 20:16:26 INFO - Running pre-action listener: _resource_record_pre_action 20:16:26 INFO - Running main action method: clobber 20:16:26 INFO - rmtree: /builds/slave/test/build 20:16:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:16:26 INFO - Running post-action listener: _resource_record_post_action 20:16:26 INFO - [mozharness: 2016-12-15 04:16:26.838599Z] Finished clobber step (success) 20:16:26 INFO - [mozharness: 2016-12-15 04:16:26.838699Z] Running read-buildbot-config step. 20:16:26 INFO - Running pre-action listener: _resource_record_pre_action 20:16:26 INFO - Running main action method: read_buildbot_config 20:16:26 INFO - Using buildbot properties: 20:16:26 INFO - { 20:16:26 INFO - "project": "", 20:16:26 INFO - "product": "firefox", 20:16:26 INFO - "script_repo_revision": "production", 20:16:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 20:16:26 INFO - "repository": "", 20:16:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 20:16:26 INFO - "buildid": "20161214183807", 20:16:26 INFO - "pgo_build": "True", 20:16:26 INFO - "basedir": "/builds/slave/test", 20:16:26 INFO - "buildnumber": 2266, 20:16:26 INFO - "slavename": "talos-linux64-ix-034", 20:16:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:16:26 INFO - "platform": "ubuntu64_hw", 20:16:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 20:16:26 INFO - "branch": "mozilla-inbound", 20:16:26 INFO - "repo_path": "integration/mozilla-inbound", 20:16:26 INFO - "revision": "3d48c2a8393ab0858920bf9493d3254e6ff120af", 20:16:26 INFO - "stage_platform": "linux64-pgo", 20:16:26 INFO - "builduid": "d13bd58dd71545ef8f1eae72468e87ca", 20:16:26 INFO - "slavebuilddir": "test" 20:16:26 INFO - } 20:16:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 20:16:26 INFO - Running post-action listener: _resource_record_post_action 20:16:26 INFO - [mozharness: 2016-12-15 04:16:26.841496Z] Finished read-buildbot-config step (success) 20:16:26 INFO - [mozharness: 2016-12-15 04:16:26.841584Z] Running download-and-extract step. 20:16:26 INFO - Running pre-action listener: _resource_record_pre_action 20:16:26 INFO - Running main action method: download_and_extract 20:16:26 INFO - mkdir: /builds/slave/test/build/tests 20:16:26 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')]} 20:16:26 INFO - trying https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:16:26 INFO - Downloading https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/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 20:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/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 20:16:27 INFO - Downloaded 1361 bytes. 20:16:27 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:16:27 INFO - Using the following test package requirements: 20:16:27 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:16:27 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:16:27 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:16:27 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:27 INFO - u'jsshell-linux-x86_64.zip'], 20:16:27 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:16:27 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:16:27 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:16:27 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:16:27 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:16:27 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:16:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:16:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:16:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:27 INFO - Fetch https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:16:28 INFO - Expected file size: 21775368 20:16:28 INFO - Obtained file size: 21775368 20:16:32 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 20:16:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:16:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:32 INFO - Fetch https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:16:33 INFO - Expected file size: 21775368 20:16:33 INFO - Obtained file size: 21775368 20:16:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:16:37 INFO - Fetch https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:16:38 INFO - Expected file size: 14409734 20:16:38 INFO - Obtained file size: 14409734 20:16:38 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')]} 20:16:38 INFO - trying https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:38 INFO - Downloading https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/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 20:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/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 20:16:40 INFO - Downloaded 59751850 bytes. 20:16:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:40 INFO - mkdir: /builds/slave/test/properties 20:16:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:16:40 INFO - Writing to file /builds/slave/test/properties/build_url 20:16:40 INFO - Contents: 20:16:40 INFO - build_url:https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:41 INFO - Running post-action listener: _resource_record_post_action 20:16:41 INFO - Running post-action listener: set_extra_try_arguments 20:16:41 INFO - [mozharness: 2016-12-15 04:16:41.121853Z] Finished download-and-extract step (success) 20:16:41 INFO - [mozharness: 2016-12-15 04:16:41.122079Z] Running populate-webroot step. 20:16:41 INFO - Running pre-action listener: _resource_record_pre_action 20:16:41 INFO - Running main action method: populate_webroot 20:16:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:16:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:16:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:16:41 INFO - '--tppagecycles', 20:16:41 INFO - '7'], 20:16:41 INFO - 'tests': ['tsvgm']}}, 20:16:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:16:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:16:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:16:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:16:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:16:41 INFO - 'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:16:41 INFO - 'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['damp', 'tps']}, 20:16:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:16:41 INFO - 'tests': ['damp', 'tps']}, 20:16:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['dromaeo_dom']}, 20:16:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:16:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['basic_compositor_video']}, 20:16:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:16:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['a11yr', 20:16:41 INFO - 'ts_paint', 20:16:41 INFO - 'tpaint', 20:16:41 INFO - 'sessionrestore', 20:16:41 INFO - 'sessionrestore_no_auto_restore', 20:16:41 INFO - 'tabpaint']}, 20:16:41 INFO - 'other-e10s': {'tests': ['a11yr', 20:16:41 INFO - 'ts_paint', 20:16:41 INFO - 'tpaint', 20:16:41 INFO - 'sessionrestore', 20:16:41 INFO - 'sessionrestore_no_auto_restore', 20:16:41 INFO - 'tabpaint']}, 20:16:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:16:41 INFO - 'ts_paint', 20:16:41 INFO - 'tpaint', 20:16:41 INFO - 'sessionrestore', 20:16:41 INFO - 'sessionrestore_no_auto_restore', 20:16:41 INFO - 'tabpaint']}, 20:16:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:16:41 INFO - 'ts_paint', 20:16:41 INFO - 'tpaint', 20:16:41 INFO - 'sessionrestore', 20:16:41 INFO - 'sessionrestore_no_auto_restore', 20:16:41 INFO - 'tabpaint']}, 20:16:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['a11yr', 20:16:41 INFO - 'ts_paint', 20:16:41 INFO - 'tpaint', 20:16:41 INFO - 'sessionrestore', 20:16:41 INFO - 'sessionrestore_no_auto_restore', 20:16:41 INFO - 'tabpaint']}, 20:16:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['a11yr', 20:16:41 INFO - 'ts_paint', 20:16:41 INFO - 'tpaint', 20:16:41 INFO - 'sessionrestore', 20:16:41 INFO - 'sessionrestore_no_auto_restore', 20:16:41 INFO - 'tabpaint']}, 20:16:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['tsvgx', 20:16:41 INFO - 'tsvgr_opacity', 20:16:41 INFO - 'tart', 20:16:41 INFO - 'tscrollx', 20:16:41 INFO - 'cart', 20:16:41 INFO - 'tsvg_static']}, 20:16:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:16:41 INFO - 'tsvgr_opacity', 20:16:41 INFO - 'tart', 20:16:41 INFO - 'tscrollx', 20:16:41 INFO - 'cart', 20:16:41 INFO - 'tsvg_static']}, 20:16:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:16:41 INFO - 'talos_options': ['--disable-e10s'], 20:16:41 INFO - 'tests': ['tp5o']}, 20:16:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:16:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:16:41 INFO - 'talos_options': ['--disable-e10s', 20:16:41 INFO - '--xperf_path', 20:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:41 INFO - 'tests': ['tp5n']}, 20:16:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:16:41 INFO - 'talos_options': ['--xperf_path', 20:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:41 INFO - 'tests': ['tp5n']}}, 20:16:41 INFO - 'talos.zip': {'path': '', 20:16:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:16:41 INFO - Running post-action listener: _resource_record_post_action 20:16:41 INFO - [mozharness: 2016-12-15 04:16:41.140916Z] Finished populate-webroot step (success) 20:16:41 INFO - [mozharness: 2016-12-15 04:16:41.141004Z] Running create-virtualenv step. 20:16:41 INFO - Running pre-action listener: _resource_record_pre_action 20:16:41 INFO - Running main action method: create_virtualenv 20:16:41 INFO - Creating virtualenv /builds/slave/test/build/venv 20:16:41 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 20:16:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:16:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:16:41 INFO - Using real prefix '/usr' 20:16:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:16:41 INFO - Installing distribute.............................................................................................................................................................................................done. 20:16:43 INFO - Installing pip.................done. 20:16:43 INFO - Return code: 0 20:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:16:43 INFO - Reading from file tmpfile_stdout 20:16:43 INFO - Output received: 20:16:43 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) 20:16:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f38aa30ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', '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 20:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:16:43 INFO - Using env: {'DISPLAY': ':0', 20:16:43 INFO - 'HOME': '/home/cltbld', 20:16:43 INFO - 'LANG': 'en_US.UTF-8', 20:16:43 INFO - 'LANGUAGE': 'en_US:en', 20:16:43 INFO - 'LOGNAME': 'cltbld', 20:16:43 INFO - 'MAIL': '/var/mail/cltbld', 20:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:43 INFO - 'MOZ_NO_REMOTE': '1', 20:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:43 INFO - 'NO_EM_RESTART': '1', 20:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:43 INFO - 'PWD': '/builds/slave/test', 20:16:43 INFO - 'SHELL': '/bin/bash', 20:16:43 INFO - 'SHLVL': '1', 20:16:43 INFO - 'TERM': 'linux', 20:16:43 INFO - 'TMOUT': '86400', 20:16:43 INFO - 'USER': 'cltbld', 20:16:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:43 INFO - '_': '/tools/buildbot/bin/python'} 20:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:44 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 20:16:44 INFO - Cleaning up... 20:16:44 INFO - Return code: 0 20:16:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:16:44 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')]} 20:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:44 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')]} 20:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:44 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 0x7f38aa30ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', '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 20:16:44 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 20:16:44 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 20:16:44 INFO - Using env: {'DISPLAY': ':0', 20:16:44 INFO - 'HOME': '/home/cltbld', 20:16:44 INFO - 'LANG': 'en_US.UTF-8', 20:16:44 INFO - 'LANGUAGE': 'en_US:en', 20:16:44 INFO - 'LOGNAME': 'cltbld', 20:16:44 INFO - 'MAIL': '/var/mail/cltbld', 20:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:44 INFO - 'MOZ_NO_REMOTE': '1', 20:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:44 INFO - 'NO_EM_RESTART': '1', 20:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:44 INFO - 'PWD': '/builds/slave/test', 20:16:44 INFO - 'SHELL': '/bin/bash', 20:16:44 INFO - 'SHLVL': '1', 20:16:44 INFO - 'TERM': 'linux', 20:16:44 INFO - 'TMOUT': '86400', 20:16:44 INFO - 'USER': 'cltbld', 20:16:44 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:44 INFO - '_': '/tools/buildbot/bin/python'} 20:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:44 INFO - Downloading/unpacking psutil>=3.1.1 20:16:44 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 20:16:44 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 20:16:44 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 20:16:44 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 20:16:44 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 20:16:44 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 20:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:16:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:46 INFO - Installing collected packages: psutil 20:16:46 INFO - Running setup.py install for psutil 20:16:46 INFO - building 'psutil._psutil_linux' extension 20:16:46 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 20:16:46 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 20:16:46 INFO - building 'psutil._psutil_posix' extension 20:16:46 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 20:16:46 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 20:16:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:47 INFO - Successfully installed psutil 20:16:47 INFO - Cleaning up... 20:16:47 INFO - Return code: 0 20:16:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f38aa30ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', '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 20:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:16:47 INFO - Using env: {'DISPLAY': ':0', 20:16:47 INFO - 'HOME': '/home/cltbld', 20:16:47 INFO - 'LANG': 'en_US.UTF-8', 20:16:47 INFO - 'LANGUAGE': 'en_US:en', 20:16:47 INFO - 'LOGNAME': 'cltbld', 20:16:47 INFO - 'MAIL': '/var/mail/cltbld', 20:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:47 INFO - 'MOZ_NO_REMOTE': '1', 20:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:47 INFO - 'NO_EM_RESTART': '1', 20:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:47 INFO - 'PWD': '/builds/slave/test', 20:16:47 INFO - 'SHELL': '/bin/bash', 20:16:47 INFO - 'SHLVL': '1', 20:16:47 INFO - 'TERM': 'linux', 20:16:47 INFO - 'TMOUT': '86400', 20:16:47 INFO - 'USER': 'cltbld', 20:16:47 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:47 INFO - '_': '/tools/buildbot/bin/python'} 20:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:16:47 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 20:16:47 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 20:16:47 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 20:16:47 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 20:16:47 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 20:16:47 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 20:16:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:16:49 INFO - Installing collected packages: mozsystemmonitor 20:16:49 INFO - Running setup.py install for mozsystemmonitor 20:16:49 INFO - Successfully installed mozsystemmonitor 20:16:49 INFO - Cleaning up... 20:16:49 INFO - Return code: 0 20:16:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f38aa30ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', '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 20:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:16:49 INFO - Using env: {'DISPLAY': ':0', 20:16:49 INFO - 'HOME': '/home/cltbld', 20:16:49 INFO - 'LANG': 'en_US.UTF-8', 20:16:49 INFO - 'LANGUAGE': 'en_US:en', 20:16:49 INFO - 'LOGNAME': 'cltbld', 20:16:49 INFO - 'MAIL': '/var/mail/cltbld', 20:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:49 INFO - 'MOZ_NO_REMOTE': '1', 20:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:49 INFO - 'NO_EM_RESTART': '1', 20:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:49 INFO - 'PWD': '/builds/slave/test', 20:16:49 INFO - 'SHELL': '/bin/bash', 20:16:49 INFO - 'SHLVL': '1', 20:16:49 INFO - 'TERM': 'linux', 20:16:49 INFO - 'TMOUT': '86400', 20:16:49 INFO - 'USER': 'cltbld', 20:16:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:49 INFO - '_': '/tools/buildbot/bin/python'} 20:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:49 INFO - Downloading/unpacking jsonschema==2.5.1 20:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:16:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:51 INFO - Downloading functools32-3.2.3-2.tar.gz 20:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:16:52 INFO - warning: no files found matching '*.txt' 20:16:52 INFO - no previously-included directories found matching 'build' 20:16:52 INFO - no previously-included directories found matching 'dist' 20:16:52 INFO - no previously-included directories found matching '.git*' 20:16:52 INFO - Installing collected packages: jsonschema, functools32 20:16:52 INFO - Running setup.py install for functools32 20:16:52 INFO - warning: no files found matching '*.txt' 20:16:52 INFO - no previously-included directories found matching 'build' 20:16:52 INFO - no previously-included directories found matching 'dist' 20:16:52 INFO - no previously-included directories found matching '.git*' 20:16:52 INFO - Successfully installed jsonschema functools32 20:16:52 INFO - Cleaning up... 20:16:52 INFO - Return code: 0 20:16:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:52 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 0x7f38aa30ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', '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 20:16:52 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 20:16:52 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 20:16:52 INFO - Using env: {'DISPLAY': ':0', 20:16:52 INFO - 'HOME': '/home/cltbld', 20:16:52 INFO - 'LANG': 'en_US.UTF-8', 20:16:52 INFO - 'LANGUAGE': 'en_US:en', 20:16:52 INFO - 'LOGNAME': 'cltbld', 20:16:52 INFO - 'MAIL': '/var/mail/cltbld', 20:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:52 INFO - 'MOZ_NO_REMOTE': '1', 20:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:52 INFO - 'NO_EM_RESTART': '1', 20:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:52 INFO - 'PWD': '/builds/slave/test', 20:16:52 INFO - 'SHELL': '/bin/bash', 20:16:52 INFO - 'SHLVL': '1', 20:16:52 INFO - 'TERM': 'linux', 20:16:52 INFO - 'TMOUT': '86400', 20:16:52 INFO - 'USER': 'cltbld', 20:16:52 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:52 INFO - '_': '/tools/buildbot/bin/python'} 20:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:16:52 INFO - Cleaning up... 20:16:52 INFO - Return code: 0 20:16:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:52 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 0x7f38aa30ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', '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 20:16:52 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 20:16:52 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 20:16:52 INFO - Using env: {'DISPLAY': ':0', 20:16:52 INFO - 'HOME': '/home/cltbld', 20:16:52 INFO - 'LANG': 'en_US.UTF-8', 20:16:52 INFO - 'LANGUAGE': 'en_US:en', 20:16:52 INFO - 'LOGNAME': 'cltbld', 20:16:52 INFO - 'MAIL': '/var/mail/cltbld', 20:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:52 INFO - 'MOZ_NO_REMOTE': '1', 20:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:52 INFO - 'NO_EM_RESTART': '1', 20:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:52 INFO - 'PWD': '/builds/slave/test', 20:16:52 INFO - 'SHELL': '/bin/bash', 20:16:52 INFO - 'SHLVL': '1', 20:16:52 INFO - 'TERM': 'linux', 20:16:52 INFO - 'TMOUT': '86400', 20:16:52 INFO - 'USER': 'cltbld', 20:16:52 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:52 INFO - '_': '/tools/buildbot/bin/python'} 20:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:52 INFO - Downloading/unpacking blobuploader==1.2.4 20:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:54 INFO - Downloading blobuploader-1.2.4.tar.gz 20:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:16:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:16:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:16:55 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 20:16:55 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 20:16:55 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 20:16:55 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 20:16:55 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 20:16:55 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 20:16:55 INFO - Downloading docopt-0.6.1.tar.gz 20:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:16:55 INFO - Installing collected packages: blobuploader, requests, docopt 20:16:55 INFO - Running setup.py install for blobuploader 20:16:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:16:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:16:55 INFO - Running setup.py install for requests 20:16:55 INFO - Running setup.py install for docopt 20:16:55 INFO - Successfully installed blobuploader requests docopt 20:16:55 INFO - Cleaning up... 20:16:56 INFO - Return code: 0 20:16:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:56 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 0x7f38aa30ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', '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 20:16:56 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 20:16:56 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 20:16:56 INFO - Using env: {'DISPLAY': ':0', 20:16:56 INFO - 'HOME': '/home/cltbld', 20:16:56 INFO - 'LANG': 'en_US.UTF-8', 20:16:56 INFO - 'LANGUAGE': 'en_US:en', 20:16:56 INFO - 'LOGNAME': 'cltbld', 20:16:56 INFO - 'MAIL': '/var/mail/cltbld', 20:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:56 INFO - 'MOZ_NO_REMOTE': '1', 20:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:56 INFO - 'NO_EM_RESTART': '1', 20:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:56 INFO - 'PWD': '/builds/slave/test', 20:16:56 INFO - 'SHELL': '/bin/bash', 20:16:56 INFO - 'SHLVL': '1', 20:16:56 INFO - 'TERM': 'linux', 20:16:56 INFO - 'TMOUT': '86400', 20:16:56 INFO - 'USER': 'cltbld', 20:16:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:56 INFO - '_': '/tools/buildbot/bin/python'} 20:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:56 INFO - Running setup.py (path:/tmp/pip-mwCrOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:56 INFO - Running setup.py (path:/tmp/pip-7oKjcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:56 INFO - Running setup.py (path:/tmp/pip-MTAw8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:56 INFO - Running setup.py (path:/tmp/pip-LVKfn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:56 INFO - Running setup.py (path:/tmp/pip-LHSPwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:56 INFO - Running setup.py (path:/tmp/pip-ixw4WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:56 INFO - Running setup.py (path:/tmp/pip-CdtXkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:56 INFO - Running setup.py (path:/tmp/pip-E2853L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:56 INFO - Running setup.py (path:/tmp/pip-LGMskz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:56 INFO - Running setup.py (path:/tmp/pip-Awt23w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:56 INFO - Running setup.py (path:/tmp/pip-h4si0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:57 INFO - Running setup.py (path:/tmp/pip-aANV_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:57 INFO - Running setup.py (path:/tmp/pip-Oxjmhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:57 INFO - Running setup.py (path:/tmp/pip-9jlndv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:57 INFO - Running setup.py (path:/tmp/pip-HSqueT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:57 INFO - Running setup.py (path:/tmp/pip-R9O0OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:57 INFO - Running setup.py (path:/tmp/pip-5yU3RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:16:57 INFO - Running setup.py install for manifestparser 20:16:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:16:57 INFO - Running setup.py install for mozcrash 20:16:57 INFO - Running setup.py install for mozdebug 20:16:57 INFO - Running setup.py install for mozdevice 20:16:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:16:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:16:57 INFO - Running setup.py install for mozfile 20:16:58 INFO - Running setup.py install for mozhttpd 20:16:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozinfo 20:16:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozInstall 20:16:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozleak 20:16:58 INFO - Running setup.py install for mozlog 20:16:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for moznetwork 20:16:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozprocess 20:16:58 INFO - Running setup.py install for mozprofile 20:16:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozrunner 20:16:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:16:58 INFO - Running setup.py install for mozscreenshot 20:16:59 INFO - Running setup.py install for moztest 20:16:59 INFO - Running setup.py install for mozversion 20:16:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:16:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:16:59 INFO - Cleaning up... 20:16:59 INFO - Return code: 0 20:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16: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')]} 20:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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')]} 20:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:59 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 0x7f38aa30ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', '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 20:16:59 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 20:16:59 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 20:16:59 INFO - Using env: {'DISPLAY': ':0', 20:16:59 INFO - 'HOME': '/home/cltbld', 20:16:59 INFO - 'LANG': 'en_US.UTF-8', 20:16:59 INFO - 'LANGUAGE': 'en_US:en', 20:16:59 INFO - 'LOGNAME': 'cltbld', 20:16:59 INFO - 'MAIL': '/var/mail/cltbld', 20:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:59 INFO - 'MOZ_NO_REMOTE': '1', 20:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:59 INFO - 'NO_EM_RESTART': '1', 20:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:59 INFO - 'PWD': '/builds/slave/test', 20:16:59 INFO - 'SHELL': '/bin/bash', 20:16:59 INFO - 'SHLVL': '1', 20:16:59 INFO - 'TERM': 'linux', 20:16:59 INFO - 'TMOUT': '86400', 20:16:59 INFO - 'USER': 'cltbld', 20:16:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:59 INFO - '_': '/tools/buildbot/bin/python'} 20:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:59 INFO - Running setup.py (path:/tmp/pip-OV1SFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:59 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)) 20:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:59 INFO - Running setup.py (path:/tmp/pip-dPhg2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:59 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)) 20:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:59 INFO - Running setup.py (path:/tmp/pip-k8oza7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:59 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)) 20:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:59 INFO - Running setup.py (path:/tmp/pip-ip8SMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:59 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)) 20:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:59 INFO - Running setup.py (path:/tmp/pip-2cFiMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:59 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)) 20:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:59 INFO - Running setup.py (path:/tmp/pip-jIPoY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:59 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)) 20:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:59 INFO - Running setup.py (path:/tmp/pip-dT4fYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:00 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)) 20:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:00 INFO - Running setup.py (path:/tmp/pip-fDC7ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:00 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)) 20:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:00 INFO - Running setup.py (path:/tmp/pip-nWSLzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:00 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)) 20:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:00 INFO - Running setup.py (path:/tmp/pip-cAdD6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:00 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)) 20:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:00 INFO - Running setup.py (path:/tmp/pip-GSC3wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:00 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)) 20:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:00 INFO - Running setup.py (path:/tmp/pip-7B2huN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:00 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)) 20:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:00 INFO - Running setup.py (path:/tmp/pip-ZuxNvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:00 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)) 20:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:00 INFO - Running setup.py (path:/tmp/pip-uBMqm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:00 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)) 20:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:00 INFO - Running setup.py (path:/tmp/pip-2yYpne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:00 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)) 20:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:00 INFO - Running setup.py (path:/tmp/pip-zx8vgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:00 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)) 20:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:00 INFO - Running setup.py (path:/tmp/pip-f5FfUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:00 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)) 20:17:00 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)) 20:17:00 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)) 20:17:00 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)) 20:17:00 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)) 20:17:00 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)) 20:17:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:17:00 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 20:17:00 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 20:17:00 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 20:17:00 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 20:17:00 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 20:17:00 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 20:17:02 INFO - Downloading blessings-1.6.tar.gz 20:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:17:02 INFO - Installing collected packages: blessings 20:17:02 INFO - Running setup.py install for blessings 20:17:02 INFO - Successfully installed blessings 20:17:02 INFO - Cleaning up... 20:17:02 INFO - Return code: 0 20:17:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:17:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:03 INFO - Reading from file tmpfile_stdout 20:17:03 INFO - Current package versions: 20:17:03 INFO - argparse == 1.2.1 20:17:03 INFO - blessings == 1.6 20:17:03 INFO - blobuploader == 1.2.4 20:17:03 INFO - docopt == 0.6.1 20:17:03 INFO - functools32 == 3.2.3-2 20:17:03 INFO - jsonschema == 2.5.1 20:17:03 INFO - manifestparser == 1.1 20:17:03 INFO - mozInstall == 1.12 20:17:03 INFO - mozcrash == 1.0 20:17:03 INFO - mozdebug == 0.1 20:17:03 INFO - mozdevice == 0.49 20:17:03 INFO - mozfile == 1.2 20:17:03 INFO - mozhttpd == 0.7 20:17:03 INFO - mozinfo == 0.9 20:17:03 INFO - mozleak == 0.1 20:17:03 INFO - mozlog == 3.4 20:17:03 INFO - moznetwork == 0.27 20:17:03 INFO - mozprocess == 0.23 20:17:03 INFO - mozprofile == 0.28 20:17:03 INFO - mozrunner == 6.13 20:17:03 INFO - mozscreenshot == 0.1 20:17:03 INFO - mozsystemmonitor == 0.3 20:17:03 INFO - moztest == 0.7 20:17:03 INFO - mozversion == 1.4 20:17:03 INFO - psutil == 3.1.1 20:17:03 INFO - requests == 1.2.3 20:17:03 INFO - wsgiref == 0.1.2 20:17:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:03 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')]} 20:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:03 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')]} 20:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:03 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 0x7f38aa30ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', '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 20:17:03 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 20:17:03 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 20:17:03 INFO - Using env: {'DISPLAY': ':0', 20:17:03 INFO - 'HOME': '/home/cltbld', 20:17:03 INFO - 'LANG': 'en_US.UTF-8', 20:17:03 INFO - 'LANGUAGE': 'en_US:en', 20:17:03 INFO - 'LOGNAME': 'cltbld', 20:17:03 INFO - 'MAIL': '/var/mail/cltbld', 20:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:03 INFO - 'MOZ_NO_REMOTE': '1', 20:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:03 INFO - 'NO_EM_RESTART': '1', 20:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:03 INFO - 'PWD': '/builds/slave/test', 20:17:03 INFO - 'SHELL': '/bin/bash', 20:17:03 INFO - 'SHLVL': '1', 20:17:03 INFO - 'TERM': 'linux', 20:17:03 INFO - 'TMOUT': '86400', 20:17:03 INFO - 'USER': 'cltbld', 20:17:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:03 INFO - '_': '/tools/buildbot/bin/python'} 20:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:03 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)) 20:17:03 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)) 20:17:03 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)) 20:17:03 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)) 20:17:03 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)) 20:17:03 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)) 20:17:03 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)) 20:17:03 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)) 20:17:03 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)) 20:17:03 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)) 20:17:03 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)) 20:17:03 INFO - Cleaning up... 20:17:03 INFO - Return code: 0 20:17:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:17:03 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')]} 20:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:03 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')]} 20:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:03 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 0x7f38aa30ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23afa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', '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 20:17:03 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 20:17:03 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 20:17:03 INFO - Using env: {'DISPLAY': ':0', 20:17:03 INFO - 'HOME': '/home/cltbld', 20:17:03 INFO - 'LANG': 'en_US.UTF-8', 20:17:03 INFO - 'LANGUAGE': 'en_US:en', 20:17:03 INFO - 'LOGNAME': 'cltbld', 20:17:03 INFO - 'MAIL': '/var/mail/cltbld', 20:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:03 INFO - 'MOZ_NO_REMOTE': '1', 20:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:03 INFO - 'NO_EM_RESTART': '1', 20:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:03 INFO - 'PWD': '/builds/slave/test', 20:17:03 INFO - 'SHELL': '/bin/bash', 20:17:03 INFO - 'SHLVL': '1', 20:17:03 INFO - 'TERM': 'linux', 20:17:03 INFO - 'TMOUT': '86400', 20:17:03 INFO - 'USER': 'cltbld', 20:17:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:03 INFO - '_': '/tools/buildbot/bin/python'} 20:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:17:03 INFO - Cleaning up... 20:17:03 INFO - Return code: 0 20:17:03 INFO - Running post-action listener: _resource_record_post_action 20:17:03 INFO - Running post-action listener: _start_resource_monitoring 20:17:03 INFO - Starting resource monitoring. 20:17:03 INFO - [mozharness: 2016-12-15 04:17:03.696657Z] Finished create-virtualenv step (success) 20:17:03 INFO - [mozharness: 2016-12-15 04:17:03.697178Z] Running install step. 20:17:03 INFO - Running pre-action listener: _resource_record_pre_action 20:17:03 INFO - Running main action method: install 20:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:03 INFO - Reading from file tmpfile_stdout 20:17:03 INFO - Detecting whether we're running mozinstall >=1.0... 20:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:17:03 INFO - Reading from file tmpfile_stdout 20:17:03 INFO - Output received: 20:17:03 INFO - Usage: mozinstall [options] installer 20:17:03 INFO - Options: 20:17:03 INFO - -h, --help show this help message and exit 20:17:03 INFO - -d DEST, --destination=DEST 20:17:03 INFO - Directory to install application into. [default: 20:17:03 INFO - "/builds/slave/test"] 20:17:03 INFO - --app=APP Application being installed. [default: firefox] 20:17:03 INFO - mkdir: /builds/slave/test/build/application 20:17:03 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'] 20:17:03 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 20:17:20 INFO - Reading from file tmpfile_stdout 20:17:20 INFO - Output received: 20:17:20 INFO - /builds/slave/test/build/application/firefox/firefox 20:17:20 INFO - Running post-action listener: _resource_record_post_action 20:17:20 INFO - [mozharness: 2016-12-15 04:17:20.991933Z] Finished install step (success) 20:17:20 INFO - [mozharness: 2016-12-15 04:17:20.992176Z] Running run-tests step. 20:17:20 INFO - Running pre-action listener: _resource_record_pre_action 20:17:20 INFO - Running main action method: run_tests 20:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:17:20 INFO - Python 2.7.3 20:17:20 INFO - Return code: 0 20:17:20 INFO - grabbing minidump binary from tooltool 20:17: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')]} 20:17:21 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 0x25ddf20>, '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 0x254ac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:17:21 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 20:17:21 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 20:17:21 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 20:17:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:17:21 INFO - Return code: 0 20:17:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:17:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:17:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:17:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:17:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 20:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 20:17:21 INFO - Using env: {'DISPLAY': ':0', 20:17:21 INFO - 'HOME': '/home/cltbld', 20:17:21 INFO - 'LANG': 'en_US.UTF-8', 20:17:21 INFO - 'LANGUAGE': 'en_US:en', 20:17:21 INFO - 'LOGNAME': 'cltbld', 20:17:21 INFO - 'MAIL': '/var/mail/cltbld', 20:17:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:17:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:21 INFO - 'MOZ_NO_REMOTE': '1', 20:17:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:21 INFO - 'NO_EM_RESTART': '1', 20:17:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:21 INFO - 'PWD': '/builds/slave/test', 20:17:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:17:21 INFO - 'SHELL': '/bin/bash', 20:17:21 INFO - 'SHLVL': '1', 20:17:21 INFO - 'TERM': 'linux', 20:17:21 INFO - 'TMOUT': '86400', 20:17:21 INFO - 'USER': 'cltbld', 20:17:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870', 20:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:21 INFO - '_': '/tools/buildbot/bin/python'} 20:17:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 20:17:21 INFO - mozversion application_buildid: 20161214183807 20:17:21 INFO - mozversion application_changeset: 3d48c2a8393ab0858920bf9493d3254e6ff120af 20:17:21 INFO - mozversion application_display_name: Nightly 20:17:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:17:21 INFO - mozversion application_name: Firefox 20:17:21 INFO - mozversion application_remotingname: firefox 20:17:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:17:21 INFO - mozversion application_vendor: Mozilla 20:17:21 INFO - mozversion application_version: 53.0a1 20:17:21 INFO - mozversion platform_buildid: 20161214183807 20:17:21 INFO - mozversion platform_changeset: 3d48c2a8393ab0858920bf9493d3254e6ff120af 20:17:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:17:21 INFO - mozversion platform_version: 53.0a1 20:17:21 INFO - using testdate: 1481775441 20:17:21 INFO - actual date: 1481775441 20:17:21 INFO - starting webserver on 'localhost:43756' 20:17:21 INFO - SUITE-START | Running 2 tests 20:17:21 INFO - TEST-START | dromaeo_css 20:17:21 INFO - operating with platform_type : linux_ 20:17:21 INFO - Initialising browser for dromaeo_css test... 20:17:21 INFO - TEST-INFO | started process 11145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ujCHp/profile http://localhost:43756/getInfo.html) 20:17:25 INFO - PROCESS | 11145 | __metrics Screen width/height:1600/1200 20:17:25 INFO - PROCESS | 11145 | colorDepth:24 20:17:25 INFO - PROCESS | 11145 | Browser inner width/height: 1024/697 20:17:25 INFO - PROCESS | 11145 | __metrics 20:17:26 INFO - PROCESS | 11145 | 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" 20:17:26 INFO - PROCESS | 11145 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:17:27 INFO - TEST-INFO | 11145: exit 0 20:17:27 INFO - Browser initialized. 20:17:27 INFO - Running cycle 1/1 for dromaeo_css test... 20:17:27 INFO - TEST-INFO | started process 11227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ujCHp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:39 INFO - PROCESS | 11227 | RSS: Main: 172412928 20:17:39 INFO - PROCESS | 11227 | 20:18:30 INFO - PROCESS | 11227 | 1481775510883 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] 20:20:41 INFO - PROCESS | 11227 | Cycle 1(1): loaded http://localhost:43756/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43756/tests/dromaeo/cssquery-ext.html) 20:20:42 INFO - PROCESS | 11227 | RSS: Main: 310984704 20:20:42 INFO - PROCESS | 11227 | 20:23:44 INFO - PROCESS | 11227 | Cycle 1(1): loaded http://localhost:43756/tests/dromaeo/cssquery-ext.html (next: http://localhost:43756/tests/dromaeo/cssquery-jquery.html) 20:23:45 INFO - PROCESS | 11227 | RSS: Main: 286576640 20:23:45 INFO - PROCESS | 11227 | 20:26:47 INFO - PROCESS | 11227 | Cycle 1(1): loaded http://localhost:43756/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43756/tests/dromaeo/cssquery-mootools.html) 20:26:48 INFO - PROCESS | 11227 | RSS: Main: 262475776 20:26:48 INFO - PROCESS | 11227 | 20:29:50 INFO - PROCESS | 11227 | Cycle 1(1): loaded http://localhost:43756/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43756/tests/dromaeo/cssquery-prototype.html) 20:29:51 INFO - PROCESS | 11227 | RSS: Main: 281096192 20:29:51 INFO - PROCESS | 11227 | 20:32:53 INFO - PROCESS | 11227 | Cycle 1(1): loaded http://localhost:43756/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43756/tests/dromaeo/cssquery-yui.html) 20:32:54 INFO - PROCESS | 11227 | RSS: Main: 227192832 20:32:54 INFO - PROCESS | 11227 | 20:35:57 INFO - PROCESS | 11227 | Cycle 1(1): loaded http://localhost:43756/tests/dromaeo/cssquery-yui.html (next: http://localhost:43756/tests/dromaeo/cssquery-dojo.html) 20:35:57 INFO - PROCESS | 11227 | RSS: Main: 320815104 20:35:57 INFO - PROCESS | 11227 | 20:35:57 INFO - PROCESS | 11227 | __start_tp_report 20:35:57 INFO - PROCESS | 11227 | _x_x_mozilla_page_load 20:35:57 INFO - PROCESS | 11227 | _x_x_mozilla_page_load_details 20:35:57 INFO - PROCESS | 11227 | |i|pagename|runs| 20:35:57 INFO - PROCESS | 11227 | |0;dojo.html;3036.939261214776;3068.5704001439817;3090.5055191169417;3097.7831551791382;3105.285784269618;5238.816641417547;5268.262443257947;5291.497307755767;5311.07056265154;5314;5360.410354860962;5372.2210279509445;5375.462453754622;5378.354597448311;5382.757775900084;4840.031993601277;4863.343448634424;4881.8779530511665;4902.803887844482;4911.214205727084;4867.1725806612785;4948.8267910623135;4952.158133117378;4955.331030310916;4957.058158949806;4862.659613827033;4912.950870491303;4918.163912134928;4939.555440010398;4960.057589058068;5011.824586139468;5023.296738456619;5032.069067222539;5035.622328325354;5072.949270507284;4746.5490778376;4772;4781.521847815226;4917.286993385975;4930.778114984834;5278.445763194886;5304.867378315535;5309.177077552986;5325.254464374991;5378.058839703036;5638.689872057035;5688.772449102031;5694.800681976111;5696.715164241813;5699.800506982236;5588.580856435784;5629.662220266756;5638.520725738276;5746.770129194827;5802.448767367136;5343.786248550054;5344.946550534522;5382.300300960928;5428.864278393072;5431.266778984826;5846.356900740915;5857.355690874;5860;5861.17943487912;5867.354590994987;5480.287562616834;5570.164475328733;5624;5627.662340259598;5633.155026746021;5609.5792815539;5638.887222255532;5657.490825825613;5663;5665.830025099253;5607.775688972395;5652.745626446737;5656.066748986454;5658.179563963202;5659.179418984307;5602.2717046783655;5655.773769049274;5656.038473459522;5665.490105890407;5708.80019199326;4422.270325396274;4425.800838962255;4437.511873693891;4463.776811159429;4467.687261891637;3939.940900886489;3962.5443074046275;3963.564007959122;3983.64147226751;4012.8996775080273;5298.682079075191;5352.732363381815;5357.919631205535;5472.315960504937;5479.04116779562;5665.178549110438;5759.568032397587;5762.884742305214;5815.680137592389;5860.736266868002;5471;5472.972635136878;5473.151661492475;5475.917861232085;5484.643498172606;4810.687305325143;4921.458639549646;4930.309756634074;4933.975330123399;4982.501749825061;5882.411758824083;5931.377205393458;5981.431763982415;5992.31088424828;6066.848328791815;5804.303483581997;5804.593678442468;5807.332156802022;5814.127880817742;5814.970925145347;5990.341062483036;5996.1005849122985;6005.969970150121;6012.819615411545;6017.217761690952;5433.212184233343;5469.699166545878;5522.171674248895;5539.473749993744;5566.081596536526;5639.125935480007;5689.487946084872;5692.829215123553;5699.971500142473;5733.655980641175;5530.059889818821;5564.276644036249;5569.944300556943;5574.9163762542785;5575;5479.4520547944885;5481.177823326533;5506.339239291311;5518.696471694096;5531.834044978657;5462.781488740406;5511.338639363302;5514.91727624078;5515.558755299647;5555.3611334697025;5589.5807814413265;5601.831945041656;5603.80386686464;5609.046462101371;5609.80365687199;5382.327209098863;5418.322709661293;5421.5391691706645;5433;5491.148871924698 20:35:57 INFO - PROCESS | 11227 | |1;ext.html;512.7666911555243;558.9552835773136;569.441946892046;574.8505388598966;575.1430368750563;30873.536896946564;31601.36797264056;39834.80082599583;40881.18237635253;41040.79479602605;43944;43950.340744888854;44313.556864431346;44391.556084439144;44473.33290000653;8371.999999999985;8603.31173506118;8607.09625489324;8607.870881936777;8677.435966662179;7826.295633393022;7869.724559640414;9943.254255930799;10091.69724908254;10203.183745300357;10284.22868284878;10338.276320657556;10350.482475876213;10351.223658225626;10357.689269321894;10287.63993260236;10345.844812327821;10346.844797328045;10352.223583231287;10361;10099.39403635777;10144.847827282596;10156.289059765819;10163.186945044452;10166.237532185041;40648.39027414591;41015.38476922848;41040.38439423381;41041.79479102615;41053;3272.5091236314506;3281.1961069538115;3362.3779600773937;3680.1167719747336;3783.791891445969;30403.69596304053;30675.386492270252;30938.845305773553;31610.209744756336;32283.19292017695;4048.1373312243168;4136.58634136587;4201.663866890642;4235.428217190671;4242.469691288589;223198;226375;227460.99999999834;227776;228984;56811;57854.13218801721;57968;58145.70927145337;58156.709216454496;59125.70437147787;59149;59264.703676482204;59351.406485935455;59367.10949335763;14740.705185896222;15034.917841842396;15164;15167.696646067017;15172.468963586221;10932.56269749217;12098.455569499394;12152.21010634306;12159.148859579744;12195;15084.094954302776;16537.421190258523;16829.326826926786;16890.662186756195;17496.650066998587;6226.159468471698;6343.1436756038265;6409.198850143732;6446.806595802133;6469.967650161719;901.1754244865874;1008.1934452438167;1050.7320633238476;1059.3749687684303;1105.6959336182615;31045.223869403446;31048;31051.689483105332;31062;31503;1081.1620993729764;1098.0940723902813;1105.3644154611131;1106.4744246483017;1149.7120729747742;15358.539243822703;16150.254456742383;16371.59071023234;16378.918105409397;16599.170041497877;453583;455477;457059;457290;457340;47970.5202947966;48892.7555362228;53387;54472.18291725627;54481;1289.4390939941156;1294.9805752913715;1307.9346032698327;1313.0611612696966;1325.304215286982;29599;31442.37115257636;31618.525722113725;31723.524147138272;31889.202769930936;48941.2658810111;49171.508284916694;49314;49335.50664493309;49453;403922;406918;407072;407252;407811;24060.759392405853;24741.50516989614;26280.737192628592;39404.408933865445;39527.209455811295;37807.62192378041;38913.22173556456;39466.605333946296;39706.2058758829;39934;32371;32908.83545582257;32926.506102408006;33250.50124248186;33500.162495937795;32211.838940805144;32326.676733232365;32941.50587741138;33435.33129337448;33658.49512257269;34468.138296542784;34537.65462345345;34587.4811877817;34639.4804077934;35398.46902296519;24461.38846528851;25916.8704156478;29810.254743631584;29924.55113173348;31004.449777511487;24653.876730616234;24747.50504989926;24809.751902480744;25372.619410709223;25508 20:35:57 INFO - PROCESS | 11227 | |2;jquery.html;361.83898165316447;377.3528398796064;381.61266314690596;390.2974645637852;411.7118017387829;13864.930675346623;17288.135593220337;18108.63782724345;19093.42719718407;19097.904510477463;17756.82243177568;18095.276188952426;18156.909215453936;18330.083495825187;18434.815651843477;5354.2771725817;5653.208550802891;5671.8582035449235;5675.716214189274;5683.374828768832;3984.561698213194;4262.232798096342;5496.148097044945;5616;5616.073347897592;4276.722013069156;6204.6587437690905;6240.968795156041;6311.905321420182;6318;6125.5712100153005;6230.376962303779;6281.277653069887;6288.4026017528495;6305.211848518935;5561.332640083176;5566.749496272678;5569.220309156722;5571.331440227158;5572.192032155314;21007.579848402947;22032.559348813094;22122.33632991013;22293;22862.885685571466;2270.9886450567806;2312.6531020346915;2313.109452860661;2370.3126093432884;2715.7420045095882;13531.39108740109;14185.57443276693;14324.283785810772;14371.712565748627;14750.778738318933;1876.268255380389;1959.6766533521952;1980.1188471130354;1986.5232344237425;2022.7774944756065;70876.93684594684;72234.63882680605;72683.63658181728;73717.26282737158;74430;9860.753481163028;9871.259655525864;10186.694399168036;10243.36360591994;10478.63324783629;14175.71648567023;14210.442120418424;14213;14213.928930355281;14221.644458888404;7599.506032107895;7805.726799562101;7862.921370786219;8081.919180808234;8113.310368618733;7400.0379950606075;7429.4799364044;7437.665305061285;7628.237176282328;7728.806779830549;6237.594556353823;6255.437010669061;6282.685865706696;6392.360763923571;6393.520485963571;1745.3106023120797;1765.8322459366339;1766;1782.9554261143576;1804.3414153833755;919.5356345045709;933.4259430450224;967;995.5019524492087;1095.0691911874842;17403.65192696139;18240.45278641643;18900.905495472434;19172.424827255203;19802.20791168366;879.9340049496185;920.9171174594319;927.4620719982394;957.2294303086082;1048.030571721155;9597.664081757244;9843.163331116792;10316.896831031743;10346.793064138676;10407.94796026015;394864;395394;396850;397628;408684;83274;84452.57773711091;84748.57625711955;84758;85468.57265713756;909.4679612426672;914.3919293669635;938.5307346326837;940.8306504829196;946.4084946908182;15276.694466110837;15276.694466110837;15666.686666266383;15996.520104396886;16251.3499460025;36265.45601816028;36587.81706091559;37038.25923481569;37519.24961500809;37579.436308455945;49176;51550;51797;52144.73927630338;53052.20421693755;5581.7209139543675;6438.645874476949;6969.616671083139;8147.75556733299;8369.623366948625;8052.114267430461;10422.530986105796;11944.581939632071;12376.009919206623;13093.279869607262;6524.967375163284;10870.293430926964;10971.945140274247;11296;11591.304521728724;10627.468626568796;10650.84023739629;11005;11069;11302.943485282522;10459.94770026145;11330.37682927447;11383.430828458379;11512.30926144434;11625.128115391548;6909.689063992032;7121.216666166821;7237.8914316286355;7426;7512.023436953161;9878.259130565093;10947.616833410792;11112.555497779998;11462.598809041978;11773.470193841127 20:35:57 INFO - PROCESS | 11227 | |3;mootools.html;1319.3930791835755;1376.9586912392629;1377.7726675098606;1499.940002399904;1674.5395016370503;7331.486795924287;7977.760667179987;8279.420440569154;8296.1703829617;8508.234258916696;8265.752027439172;8269.338452923766;8336.124706905779;8339.166083391658;8342.708005219818;1872.7565416495904;2171.543975765091;2208.9226877059305;2209.149477451185;2209.812165965895;1953.716711076893;2156.8598041127357;2212.1704360864674;2226.677131815886;2229.208630936019;2154.956900861982;2172.0985790896757;2176.9020394082227;2178.6405243134864;2180;2131.1688441507827;2142.8071473567375;2143.142742902836;2148.3232781673723;2166.7183266175452;2099.17082752312;2109.1457959526415;2112.714783504223;2115.661494160927;2129.55279391328;8155.266026057624;8276;8280.171982801672;8305.792355191108;8329.708460203925;4974;5117.1556693145585;5120.129577971754;5123.795048198068;5131.102057139986;3128.482685897338;3246.8863589774246;3321.684439978198;3334.3664703706218;3365.528825964367;1013.4729940430934;1082.7022568793566;1129.7006293332274;1131.2420678145663;1132.2413982631574;11495.310281383145;11522.76954460906;11540.422978851107;11543.422828858524;11544.653660390202;4488.102379524108;4558.156741002858;4629.976850115728;4661.650376221797;4667.696599721007;9188;9206.723798286062;9270.44377337362;9289.16397524226;9325.440473571607;5163.251328557338;5169.586433085344;5173.637845350864;5175.611829112831;5176.7411629418375;4451.643868490513;4532.864014079583;4574.771261436915;4823;4830.492798256132;3570.9285814283567;3640.344737947195;3652.123490362294;3669.743117981716;3677.3564626190846;1124.5839039555417;1148.9540418383338;1151.3897634253858;1158.965231043053;1165.4813607944552;728.8287252495659;844.6368061733514;845.5222799118478;854.7008547008497;928.3733479901175;5204.9739751301;5365.9731701342025;5409.6213265071065;5583.274174357389;5635.464630860061;419.57832378459455;420.7265277569604;433.99349009764876;438.27027998382334;446.2881703682621;3534.8939531814085;3590.2101537661674;3596.0871693928;3650.233450975272;3689.760165589228;9787.217022638171;10106.494675266355;10214.285000050073;10230;10270.743231419274;8877.822443551093;9248.213901818286;9382.85925711115;10163.237757168243;10169.13562347194;7605.23947605235;7836.138024817265;7844.568548729874;7850;7861.331786798186;5497.202905578589;5555.8888822224135;5629.6903670298525;5648.152777083306;5868.354481007001;9361.157495825137;9409.623615055321;9426.387284826464;9439.622415103318;9521.761955951157;8371.790705232173;8904.376693631642;9327.953360233156;9329.58016889228;9601.231901448007;6706.094677218513;7077.504574679929;7087.362137407658;7156.320149585781;7375.225601311785;7851.725189618336;7898.723544675909;7962.601869906365;7986.361091112581;8058.556779377191;7194.4244460442;7222.819429514304;7223.783286501413;7235.782926512213;7273.272672732684;6883.931160688529;6923.792286231421;7162.355388015104;7186.1376634804155;7366.337029667356;6375.6174629522375;6751.493637977073;6849.075374824335;6853.691583878837;6854.485913556404;4489.124620698933;4535;4581;4705.12955103307;4811.879703007453;4653.976730116327;4661.114388266218;4795.472498025145;4798.23228283473;4887.0714564232685 20:35:57 INFO - PROCESS | 11227 | |4;prototype.html;368.5319644052054;376.4860964783071;376.94157405602135;379.26801273542054;385.70686278428406;5162;5228.451012643674;5229.189475631274;5241.475852414756;5268.235141227693;5162.199859021848;5162.561182299509;5167.819126330579;5170.560502357304;5174.223866420039;3684.5762737285154;3936.1537269487053;4054.3107671695884;4167.895507690457;4183.686223533247;4095.897602559945;4112.814923328442;4122.083231297446;4138.917221655565;4147.398627199054;4073.124278280169;4090.5909409059154;4093.099518106012;4100.528439229497;4129.194807012634;3991.7405368651234;4070.5725898780497;4126.42230087788;4145.31602285624;4156.542780294165;3635.1820840310984;3651.434027725707;3659.451082337644;3704.240630670706;3710.424884142962;4973.676711013773;4984.255510571307;4992.725400102993;5006.69959802413;5034.496550344973;4573.63410927125;4664.113818374498;4671.649626278008;4685.1800934836265;4706.599939005188;5323.920141197885;5358.196270559409;5363.704996225206;5363.812266570651;5368.892622147574;4058.6347228749555;4068.776217308047;4073.4500842386196;4085.387191921206;4101.794910254475;5284.313039304904;5297.913927644823;5460.372057213432;5501.092319767234;5568.3596386415675;4142.2751018572235;4161.209370219649;4164.68764842638;4177.310743727251;4190;4244.830206791756;4254.914901701949;4261.509926358446;4267.637250833652;4274.551172126944;4393.626541743924;4614.062093920561;4761.309610106515;4767.833125840579;4799.688020278741;5429.158480435539;5432.076546986943;5442.537384322298;5444.754986025639;5451.318585176853;1364.0587994283912;1365.8322134574994;1371.8010888421122;1375.2848518770384;1377.0085538412327;911.0722770916489;936.1247233836249;940;943.8395472769646;966.6568368229318;5105.259737338065;5148.510891465305;5149.716765577929;5155.510226528474;5165.715885626327;5379.381371142291;5429.864253393696;5443.673379597237;5463.328853829918;5494.2857428534035;4975.255755726354;4983.4302194808515;5103.438621751604;5155.226715992631;5161.270974223602;2818.436312737461;2839.6734375547076;2857.457083154194;2861.914142575726;2863.226928729273;5515.393306736256;5568.9443105568425;5575.961101199856;5579.38626751057;5600.299962504687;5351.331083614548;5391.495527906892;5618.6628802272;5662.68855212959;5672.801451949162;5717.056685646905;5756.913646295309;5766.722144752883;5771.538276937918;5772.624779389326;5513.862153446035;5566.666000040011;5577.191307260506;5606.355269143937;5634.183043458594;5529.419410961791;5561.694106824163;5561.721913904208;5563.970665426909;5567.832965011056;5517.006938751063;5627.803026894039;5635.436456354331;5783.652980821164;5785.27684039495;4020.276350256982;4023.195360927885;4049.372347286175;4054.9797251013556;4064.8577299794365;5351.571874249973;5607.850390669984;5643.068893632505;5652.293463317085;5659.462351076641;5429.837104886859;5434.673919564839;5452.727363631882;5463;5475.318602594724;5438.4561543846885;5440.510354067995;5451.563874890078;5471.945280547144;5473.945260547343;5147.2279158126585;5346.97326513365;5379.19312103172;5399.487048730364;5401.243825864303;5451.0921177587525;5461.934922690038;5481.945180548303;5493.615446918678;5500.50495455411;5349.111479801019;5358.490943360374;5358.517733404013;5369.865753356197;5375.838724838261 20:35:57 INFO - PROCESS | 11227 | |5;yui.html;698.1168821440878;698.975535856245;709.3722055980462;720.6828995242093;745.8881167824826;15307.464238751645;16613.91693041533;16619.08595027273;16640.58398540037;16756.32974681013;14878.404863805461;15093.471728489505;15258.542243732678;15266.084034957883;15287.388504459808;788.9132195458509;798.9440739148262;806.31060443321;806.6047636658025;807.2452257139594;748.9887651685202;749.5203070035182;749.5352881213628;753.3107206905702;754.5472716370189;832.1013305629905;832.9625166867505;833.9166083391673;834.253343257784;834.3783881008657;821.9260266575977;825.471698113205;826;829.1708291708292;831;604.2537466229203;606.8937935861206;606.9817905462843;609.9481544068759;611.2298503885137;13277.46890124394;13601.183928964294;13646.863531364757;14187.78718319226;14312.713745725026;12449.688757781038;13038.543650972266;13104.2137471752;13120.146276265448;13201.735965280737;10752.784944301071;10880.510377033053;10912.454377281183;11237.213395062348;11296;3574.249407624376;3609.2420591675777;3650.3246899323444;3804.1630841214887;3806.828692708807;72149.27850721478;74797.25202747957;75740.24259757387;75853.62073189655;76657;9609.807803843883;9751.21990240779;9786.902130978599;9891.851622225673;9906;18948.905255473634;19765.505862353268;19931.501712457015;19951.800481995284;19954.30159944395;8325.417220794607;8355.791105222417;8383.622736976851;8525.914740852511;8649.827003459895;4505.414296141481;4508.278675411918;4535.841245556456;4674.368960190399;4702.106599746037;3520.067182196669;3589.3180295743723;3604.098975256186;3604.116991337139;3645.54430696163;613.1232337756961;614.2475467552213;615.2217444932164;634.4987459906714;635.6726285962641;644.560339116442;648.4585371214994;690.1890278922247;719.7876626395226;727.1201845766682;9827.150126463246;9902.653407130716;10062.547185376676;10091.394516329045;10130.138938190335;700.0786105219426;704.4434896431864;718.8490417012381;722.7000794670258;734.7795661301589;4463.754493502888;4644.767761611906;4776.817944185787;4897.657163998557;4944.8763780905765;62612;78114.6094269525;78588;81129;81837.59081204556;66690.66654666695;67840.32159678439;68256.6587167061;68354.65822670855;68523;61618.38381616216;62085.689571551855;62622.68688656619;63096;64296.357036429974;9211.124943130391;9447;9585.856212156683;9666.420014799134;9677.854832177663;42984.57015429805;43459.78270108629;43609.12781744411;44589;46097.53902460932;53789.46210538001;55465;59450.70274648599;60820;62305;11335;11402.942985285352;11781.293122412682;11852.881471185177;11921.165518413627;14441;14634.634134146732;14793.92603036978;14893.925530372711;15055.623609409853;14272.21502817355;14372.49696260626;14541.563753087425;14699.338529765972;14799;13849.16904985704;14208.857911420753;14309.21299328547;14826.40694372213;14889.478868239992;13875.167489950636;14154.646133846736;14170.929145354206;14713.117212967256;14836.629084272548;11336.94331528337;11592.188546801643;11696.649100526998;11739.954341306156;11827.704307392383;10251.48742562854;11622.6513204604;11844.822327664919;12062.577809776616;12251 20:35:57 INFO - PROCESS | 11227 | __end_tp_report 20:35:57 INFO - PROCESS | 11227 | __start_cc_report 20:35:57 INFO - PROCESS | 11227 | _x_x_mozilla_cycle_collect,1297 20:35:57 INFO - PROCESS | 11227 | __end_cc_report 20:35:57 INFO - PROCESS | 11227 | __startTimestamp1481776557650__endTimestamp 20:35:57 INFO - PROCESS | 11227 | 20:35:57 INFO - PROCESS | 11227 | ------- Summary: start ------- 20:35:57 INFO - PROCESS | 11227 | Number of tests: 6 20:35:57 INFO - PROCESS | 11227 | 20:35:57 INFO - PROCESS | 11227 | [#0] dojo.html Cycles:165 Average:5314.22 Median:5480.29 stddev:588.45 (10.7%) stddev-sans-first:562.48 20:35:57 INFO - PROCESS | 11227 | Values: 3036.9 3068.6 3090.5 3097.8 3105.3 5238.8 5268.3 5291.5 5311.1 5314.0 5360.4 5372.2 5375.5 5378.4 5382.8 4840.0 4863.3 4881.9 4902.8 4911.2 4867.2 4948.8 4952.2 4955.3 4957.1 4862.7 4913.0 4918.2 4939.6 4960.1 5011.8 5023.3 5032.1 5035.6 5072.9 4746.5 4772.0 4781.5 4917.3 4930.8 5278.4 5304.9 5309.2 5325.3 5378.1 5638.7 5688.8 5694.8 5696.7 5699.8 5588.6 5629.7 5638.5 5746.8 5802.4 5343.8 5344.9 5382.3 5428.9 5431.3 5846.4 5857.4 5860.0 5861.2 5867.4 5480.3 5570.2 5624.0 5627.7 5633.2 5609.6 5638.9 5657.5 5663.0 5665.8 5607.8 5652.7 5656.1 5658.2 5659.2 5602.3 5655.8 5656.0 5665.5 5708.8 4422.3 4425.8 4437.5 4463.8 4467.7 3939.9 3962.5 3963.6 3983.6 4012.9 5298.7 5352.7 5357.9 5472.3 5479.0 5665.2 5759.6 5762.9 5815.7 5860.7 5471.0 5473.0 5473.2 5475.9 5484.6 4810.7 4921.5 4930.3 4934.0 4982.5 5882.4 5931.4 5981.4 5992.3 6066.8 5804.3 5804.6 5807.3 5814.1 5815.0 5990.3 5996.1 6006.0 6012.8 6017.2 5433.2 5469.7 5522.2 5539.5 5566.1 5639.1 5689.5 5692.8 5700.0 5733.7 5530.1 5564.3 5569.9 5574.9 5575.0 5479.5 5481.2 5506.3 5518.7 5531.8 5462.8 5511.3 5514.9 5515.6 5555.4 5589.6 5601.8 5603.8 5609.0 5609.8 5382.3 5418.3 5421.5 5433.0 5491.1 20:35:57 INFO - PROCESS | 11227 | 20:35:57 INFO - PROCESS | 11227 | [#1] ext.html Cycles:180 Average:52038.28 Median:18095.02 stddev:99724.75 (551.1%) stddev-sans-first:99929.47 20:35:57 INFO - PROCESS | 11227 | Values: 512.8 559.0 569.4 574.9 575.1 30873.5 31601.4 39834.8 40881.2 41040.8 43944.0 43950.3 44313.6 44391.6 44473.3 8372.0 8603.3 8607.1 8607.9 8677.4 7826.3 7869.7 9943.3 10091.7 10203.2 10284.2 10338.3 10350.5 10351.2 10357.7 10287.6 10345.8 10346.8 10352.2 10361.0 10099.4 10144.8 10156.3 10163.2 10166.2 40648.4 41015.4 41040.4 41041.8 41053.0 3272.5 3281.2 3362.4 3680.1 3783.8 30403.7 30675.4 30938.8 31610.2 32283.2 4048.1 4136.6 4201.7 4235.4 4242.5 223198.0 226375.0 227461.0 227776.0 228984.0 56811.0 57854.1 57968.0 58145.7 58156.7 59125.7 59149.0 59264.7 59351.4 59367.1 14740.7 15034.9 15164.0 15167.7 15172.5 10932.6 12098.5 12152.2 12159.1 12195.0 15084.1 16537.4 16829.3 16890.7 17496.7 6226.2 6343.1 6409.2 6446.8 6470.0 901.2 1008.2 1050.7 1059.4 1105.7 31045.2 31048.0 31051.7 31062.0 31503.0 1081.2 1098.1 1105.4 1106.5 1149.7 15358.5 16150.3 16371.6 16378.9 16599.2 453583.0 455477.0 457059.0 457290.0 457340.0 47970.5 48892.8 53387.0 54472.2 54481.0 1289.4 1295.0 1307.9 1313.1 1325.3 29599.0 31442.4 31618.5 31723.5 31889.2 48941.3 49171.5 49314.0 49335.5 49453.0 403922.0 406918.0 407072.0 407252.0 407811.0 24060.8 24741.5 26280.7 39404.4 39527.2 37807.6 38913.2 39466.6 39706.2 39934.0 32371.0 32908.8 32926.5 33250.5 33500.2 32211.8 32326.7 32941.5 33435.3 33658.5 34468.1 34537.7 34587.5 34639.5 35398.5 24461.4 25916.9 29810.3 29924.6 31004.4 24653.9 24747.5 24809.8 25372.6 25508.0 20:35:57 INFO - PROCESS | 11227 | 20:35:57 INFO - PROCESS | 11227 | [#2] jquery.html Cycles:180 Average:25381.29 Median:396122.00 stddev:65934.84 (16.6%) stddev-sans-first:66093.04 20:35:57 INFO - PROCESS | 11227 | Values: 361.8 377.4 381.6 390.3 411.7 13864.9 17288.1 18108.6 19093.4 19097.9 17756.8 18095.3 18156.9 18330.1 18434.8 5354.3 5653.2 5671.9 5675.7 5683.4 3984.6 4262.2 5496.1 5616.0 5616.1 4276.7 6204.7 6241.0 6311.9 6318.0 6125.6 6230.4 6281.3 6288.4 6305.2 5561.3 5566.7 5569.2 5571.3 5572.2 21007.6 22032.6 22122.3 22293.0 22862.9 2271.0 2312.7 2313.1 2370.3 2715.7 13531.4 14185.6 14324.3 14371.7 14750.8 1876.3 1959.7 1980.1 1986.5 2022.8 70876.9 72234.6 72683.6 73717.3 74430.0 9860.8 9871.3 10186.7 10243.4 10478.6 14175.7 14210.4 14213.0 14213.9 14221.6 7599.5 7805.7 7862.9 8081.9 8113.3 7400.0 7429.5 7437.7 7628.2 7728.8 6237.6 6255.4 6282.7 6392.4 6393.5 1745.3 1765.8 1766.0 1783.0 1804.3 919.5 933.4 967.0 995.5 1095.1 17403.7 18240.5 18900.9 19172.4 19802.2 879.9 920.9 927.5 957.2 1048.0 9597.7 9843.2 10316.9 10346.8 10407.9 394864.0 395394.0 396850.0 397628.0 408684.0 83274.0 84452.6 84748.6 84758.0 85468.6 909.5 914.4 938.5 940.8 946.4 15276.7 15276.7 15666.7 15996.5 16251.3 36265.5 36587.8 37038.3 37519.2 37579.4 49176.0 51550.0 51797.0 52144.7 53052.2 5581.7 6438.6 6969.6 8147.8 8369.6 8052.1 10422.5 11944.6 12376.0 13093.3 6525.0 10870.3 10971.9 11296.0 11591.3 10627.5 10650.8 11005.0 11069.0 11302.9 10459.9 11330.4 11383.4 11512.3 11625.1 6909.7 7121.2 7237.9 7426.0 7512.0 9878.3 10947.6 11112.6 11462.6 11773.5 20:35:57 INFO - PROCESS | 11227 | 20:35:57 INFO - PROCESS | 11227 | [#3] mootools.html Cycles:180 Average:5382.59 Median:4930.54 stddev:3054.02 (61.9%) stddev-sans-first:3047.32 20:35:57 INFO - PROCESS | 11227 | Values: 1319.4 1377.0 1377.8 1499.9 1674.5 7331.5 7977.8 8279.4 8296.2 8508.2 8265.8 8269.3 8336.1 8339.2 8342.7 1872.8 2171.5 2208.9 2209.1 2209.8 1953.7 2156.9 2212.2 2226.7 2229.2 2155.0 2172.1 2176.9 2178.6 2180.0 2131.2 2142.8 2143.1 2148.3 2166.7 2099.2 2109.1 2112.7 2115.7 2129.6 8155.3 8276.0 8280.2 8305.8 8329.7 4974.0 5117.2 5120.1 5123.8 5131.1 3128.5 3246.9 3321.7 3334.4 3365.5 1013.5 1082.7 1129.7 1131.2 1132.2 11495.3 11522.8 11540.4 11543.4 11544.7 4488.1 4558.2 4630.0 4661.7 4667.7 9188.0 9206.7 9270.4 9289.2 9325.4 5163.3 5169.6 5173.6 5175.6 5176.7 4451.6 4532.9 4574.8 4823.0 4830.5 3570.9 3640.3 3652.1 3669.7 3677.4 1124.6 1149.0 1151.4 1159.0 1165.5 728.8 844.6 845.5 854.7 928.4 5205.0 5366.0 5409.6 5583.3 5635.5 419.6 420.7 434.0 438.3 446.3 3534.9 3590.2 3596.1 3650.2 3689.8 9787.2 10106.5 10214.3 10230.0 10270.7 8877.8 9248.2 9382.9 10163.2 10169.1 7605.2 7836.1 7844.6 7850.0 7861.3 5497.2 5555.9 5629.7 5648.2 5868.4 9361.2 9409.6 9426.4 9439.6 9521.8 8371.8 8904.4 9328.0 9329.6 9601.2 6706.1 7077.5 7087.4 7156.3 7375.2 7851.7 7898.7 7962.6 7986.4 8058.6 7194.4 7222.8 7223.8 7235.8 7273.3 6883.9 6923.8 7162.4 7186.1 7366.3 6375.6 6751.5 6849.1 6853.7 6854.5 4489.1 4535.0 4581.0 4705.1 4811.9 4654.0 4661.1 4795.5 4798.2 4887.1 20:35:57 INFO - PROCESS | 11227 | 20:35:57 INFO - PROCESS | 11227 | [#4] prototype.html Cycles:180 Average:4583.76 Median:5172.39 stddev:1318.67 (25.5%) stddev-sans-first:1283.85 20:35:57 INFO - PROCESS | 11227 | Values: 368.5 376.5 376.9 379.3 385.7 5162.0 5228.5 5229.2 5241.5 5268.2 5162.2 5162.6 5167.8 5170.6 5174.2 3684.6 3936.2 4054.3 4167.9 4183.7 4095.9 4112.8 4122.1 4138.9 4147.4 4073.1 4090.6 4093.1 4100.5 4129.2 3991.7 4070.6 4126.4 4145.3 4156.5 3635.2 3651.4 3659.5 3704.2 3710.4 4973.7 4984.3 4992.7 5006.7 5034.5 4573.6 4664.1 4671.6 4685.2 4706.6 5323.9 5358.2 5363.7 5363.8 5368.9 4058.6 4068.8 4073.5 4085.4 4101.8 5284.3 5297.9 5460.4 5501.1 5568.4 4142.3 4161.2 4164.7 4177.3 4190.0 4244.8 4254.9 4261.5 4267.6 4274.6 4393.6 4614.1 4761.3 4767.8 4799.7 5429.2 5432.1 5442.5 5444.8 5451.3 1364.1 1365.8 1371.8 1375.3 1377.0 911.1 936.1 940.0 943.8 966.7 5105.3 5148.5 5149.7 5155.5 5165.7 5379.4 5429.9 5443.7 5463.3 5494.3 4975.3 4983.4 5103.4 5155.2 5161.3 2818.4 2839.7 2857.5 2861.9 2863.2 5515.4 5568.9 5576.0 5579.4 5600.3 5351.3 5391.5 5618.7 5662.7 5672.8 5717.1 5756.9 5766.7 5771.5 5772.6 5513.9 5566.7 5577.2 5606.4 5634.2 5529.4 5561.7 5561.7 5564.0 5567.8 5517.0 5627.8 5635.4 5783.7 5785.3 4020.3 4023.2 4049.4 4055.0 4064.9 5351.6 5607.9 5643.1 5652.3 5659.5 5429.8 5434.7 5452.7 5463.0 5475.3 5438.5 5440.5 5451.6 5471.9 5473.9 5147.2 5347.0 5379.2 5399.5 5401.2 5451.1 5461.9 5481.9 5493.6 5500.5 5349.1 5358.5 5358.5 5369.9 5375.8 20:35:57 INFO - PROCESS | 11227 | 20:35:57 INFO - PROCESS | 11227 | [#5] yui.html Cycles:180 Average:17434.63 Median:4837.24 stddev:22145.59 (457.8%) stddev-sans-first:22172.06 20:35:57 INFO - PROCESS | 11227 | Values: 698.1 699.0 709.4 720.7 745.9 15307.5 16613.9 16619.1 16640.6 16756.3 14878.4 15093.5 15258.5 15266.1 15287.4 788.9 798.9 806.3 806.6 807.2 749.0 749.5 749.5 753.3 754.5 832.1 833.0 833.9 834.3 834.4 821.9 825.5 826.0 829.2 831.0 604.3 606.9 607.0 609.9 611.2 13277.5 13601.2 13646.9 14187.8 14312.7 12449.7 13038.5 13104.2 13120.1 13201.7 10752.8 10880.5 10912.5 11237.2 11296.0 3574.2 3609.2 3650.3 3804.2 3806.8 72149.3 74797.3 75740.2 75853.6 76657.0 9609.8 9751.2 9786.9 9891.9 9906.0 18948.9 19765.5 19931.5 19951.8 19954.3 8325.4 8355.8 8383.6 8525.9 8649.8 4505.4 4508.3 4535.8 4674.4 4702.1 3520.1 3589.3 3604.1 3604.1 3645.5 613.1 614.2 615.2 634.5 635.7 644.6 648.5 690.2 719.8 727.1 9827.2 9902.7 10062.5 10091.4 10130.1 700.1 704.4 718.8 722.7 734.8 4463.8 4644.8 4776.8 4897.7 4944.9 62612.0 78114.6 78588.0 81129.0 81837.6 66690.7 67840.3 68256.7 68354.7 68523.0 61618.4 62085.7 62622.7 63096.0 64296.4 9211.1 9447.0 9585.9 9666.4 9677.9 42984.6 43459.8 43609.1 44589.0 46097.5 53789.5 55465.0 59450.7 60820.0 62305.0 11335.0 11402.9 11781.3 11852.9 11921.2 14441.0 14634.6 14793.9 14893.9 15055.6 14272.2 14372.5 14541.6 14699.3 14799.0 13849.2 14208.9 14309.2 14826.4 14889.5 13875.2 14154.6 14170.9 14713.1 14836.6 11336.9 11592.2 11696.6 11740.0 11827.7 10251.5 11622.7 11844.8 12062.6 12251.0 20:35:57 INFO - PROCESS | 11227 | -------- Summary: end -------- 20:35:57 INFO - PROCESS | 11227 | 20:35:58 INFO - TEST-INFO | 11227: exit 0 20:35:58 INFO - TEST-OK | dromaeo_css | took 1117340ms 20:35:58 INFO - TEST-START | kraken 20:35:58 INFO - operating with platform_type : linux_ 20:35:58 INFO - Initialising browser for kraken test... 20:35:58 INFO - TEST-INFO | started process 11532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4u_Gkk/profile http://localhost:43756/getInfo.html) 20:36:02 INFO - PROCESS | 11532 | __metrics Screen width/height:1600/1200 20:36:02 INFO - PROCESS | 11532 | colorDepth:24 20:36:02 INFO - PROCESS | 11532 | Browser inner width/height: 1024/697 20:36:02 INFO - PROCESS | 11532 | __metrics 20:36:03 INFO - PROCESS | 11532 | 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" 20:36:03 INFO - PROCESS | 11532 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:36:04 INFO - TEST-INFO | 11532: exit 0 20:36:04 INFO - Browser initialized. 20:36:04 INFO - Running cycle 1/1 for kraken test... 20:36:04 INFO - TEST-INFO | started process 11616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4u_Gkk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:36:16 INFO - PROCESS | 11616 | RSS: Main: 172679168 20:36:16 INFO - PROCESS | 11616 | 20:36:19 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43756/tests/kraken/driver.html?testName=audio-beat-detection) 20:36:20 INFO - PROCESS | 11616 | RSS: Main: 231002112 20:36:20 INFO - PROCESS | 11616 | 20:36:22 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43756/tests/kraken/driver.html?testName=audio-dft) 20:36:23 INFO - PROCESS | 11616 | RSS: Main: 217227264 20:36:23 INFO - PROCESS | 11616 | 20:36:26 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43756/tests/kraken/driver.html?testName=audio-fft) 20:36:26 INFO - PROCESS | 11616 | RSS: Main: 299388928 20:36:26 INFO - PROCESS | 11616 | 20:36:28 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43756/tests/kraken/driver.html?testName=audio-oscillator) 20:36:29 INFO - PROCESS | 11616 | RSS: Main: 210464768 20:36:29 INFO - PROCESS | 11616 | 20:36:31 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43756/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:36:32 INFO - PROCESS | 11616 | RSS: Main: 214036480 20:36:32 INFO - PROCESS | 11616 | 20:36:35 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43756/tests/kraken/driver.html?testName=imaging-darkroom) 20:36:36 INFO - PROCESS | 11616 | RSS: Main: 253554688 20:36:36 INFO - PROCESS | 11616 | 20:36:39 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43756/tests/kraken/driver.html?testName=imaging-desaturate) 20:36:40 INFO - PROCESS | 11616 | RSS: Main: 254197760 20:36:40 INFO - PROCESS | 11616 | 20:36:42 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43756/tests/kraken/driver.html?testName=json-parse-financial) 20:36:43 INFO - PROCESS | 11616 | RSS: Main: 252157952 20:36:43 INFO - PROCESS | 11616 | 20:36:44 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43756/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:36:45 INFO - PROCESS | 11616 | RSS: Main: 213868544 20:36:45 INFO - PROCESS | 11616 | 20:36:47 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43756/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:36:48 INFO - PROCESS | 11616 | RSS: Main: 222121984 20:36:48 INFO - PROCESS | 11616 | 20:36:50 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43756/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:36:50 INFO - PROCESS | 11616 | RSS: Main: 229584896 20:36:50 INFO - PROCESS | 11616 | 20:36:53 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:36:54 INFO - PROCESS | 11616 | RSS: Main: 238702592 20:36:54 INFO - PROCESS | 11616 | 20:36:56 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:36:57 INFO - PROCESS | 11616 | RSS: Main: 235720704 20:36:57 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | Cycle 1(1): loaded http://localhost:43756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43756/tests/kraken/driver.html?testName=ai-astar) 20:36:59 INFO - PROCESS | 11616 | RSS: Main: 287719424 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | __start_tp_report 20:36:59 INFO - PROCESS | 11616 | _x_x_mozilla_page_load 20:36:59 INFO - PROCESS | 11616 | _x_x_mozilla_page_load_details 20:36:59 INFO - PROCESS | 11616 | |i|pagename|runs| 20:36:59 INFO - PROCESS | 11616 | |0;ai-astar;111;113;113;113;112;112;112;113;111;114 20:36:59 INFO - PROCESS | 11616 | |1;audio-beat-detection;156;132;124;155;130;127;121;125;150;122 20:36:59 INFO - PROCESS | 11616 | |2;audio-dft;162;161;162;163;161;163;164;163;162;163 20:36:59 INFO - PROCESS | 11616 | |3;audio-fft;75;76;75;107;83;76;77;76;90;76 20:36:59 INFO - PROCESS | 11616 | |4;audio-oscillator;85;85;113;85;84;84;102;84;84;107 20:36:59 INFO - PROCESS | 11616 | |5;imaging-gaussian-blur;127;126;128;127;127;126;127;127;127;126 20:36:59 INFO - PROCESS | 11616 | |6;imaging-darkroom;146;146;147;146;146;146;147;147;146;147 20:36:59 INFO - PROCESS | 11616 | |7;imaging-desaturate;95;95;96;95;96;95;95;95;95;95 20:36:59 INFO - PROCESS | 11616 | |8;json-parse-financial;53;64;53;52;55;53;53;53;54;53 20:36:59 INFO - PROCESS | 11616 | |9;json-stringify-tinderbox;63;64;65;64;65;65;64;65;64;65 20:36:59 INFO - PROCESS | 11616 | |10;stanford-crypto-aes;87;80;81;81;81;82;82;85;81;79 20:36:59 INFO - PROCESS | 11616 | |11;stanford-crypto-ccm;139;145;131;137;147;135;138;136;177;141 20:36:59 INFO - PROCESS | 11616 | |12;stanford-crypto-pbkdf2;168;167;167;166;171;169;174;167;168;169 20:36:59 INFO - PROCESS | 11616 | |13;stanford-crypto-sha256-iterative;65;63;64;63;64;67;68;63;63;63 20:36:59 INFO - PROCESS | 11616 | __end_tp_report 20:36:59 INFO - PROCESS | 11616 | __start_cc_report 20:36:59 INFO - PROCESS | 11616 | _x_x_mozilla_cycle_collect,1659 20:36:59 INFO - PROCESS | 11616 | __end_cc_report 20:36:59 INFO - PROCESS | 11616 | __startTimestamp1481776619457__endTimestamp 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | ------- Summary: start ------- 20:36:59 INFO - PROCESS | 11616 | Number of tests: 14 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:0.97 (0.9%) stddev-sans-first:0.88 20:36:59 INFO - PROCESS | 11616 | Values: 111.0 113.0 113.0 113.0 112.0 112.0 112.0 113.0 111.0 114.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:131.00 stddev:13.92 (10.6%) stddev-sans-first:12.33 20:36:59 INFO - PROCESS | 11616 | Values: 156.0 132.0 124.0 155.0 130.0 127.0 121.0 125.0 150.0 122.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 20:36:59 INFO - PROCESS | 11616 | Values: 162.0 161.0 162.0 163.0 161.0 163.0 164.0 163.0 162.0 163.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:10.27 (13.5%) stddev-sans-first:10.65 20:36:59 INFO - PROCESS | 11616 | Values: 75.0 76.0 75.0 107.0 83.0 76.0 77.0 76.0 90.0 76.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:84.00 stddev:11.37 (13.5%) stddev-sans-first:11.83 20:36:59 INFO - PROCESS | 11616 | Values: 85.0 85.0 113.0 85.0 84.0 84.0 102.0 84.0 84.0 107.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#5] imaging-gaussian-blur Cycles:10 Average:126.80 Median:127.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 20:36:59 INFO - PROCESS | 11616 | Values: 127.0 126.0 128.0 127.0 127.0 126.0 127.0 127.0 127.0 126.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:36:59 INFO - PROCESS | 11616 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:36:59 INFO - PROCESS | 11616 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.00 stddev:3.50 (6.6%) stddev-sans-first:3.68 20:36:59 INFO - PROCESS | 11616 | Values: 53.0 64.0 53.0 52.0 55.0 53.0 53.0 53.0 54.0 53.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 20:36:59 INFO - PROCESS | 11616 | Values: 63.0 64.0 65.0 64.0 65.0 65.0 64.0 65.0 64.0 65.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.50 stddev:2.38 (2.9%) stddev-sans-first:1.66 20:36:59 INFO - PROCESS | 11616 | Values: 87.0 80.0 81.0 81.0 81.0 82.0 82.0 85.0 81.0 79.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:140.00 stddev:12.96 (9.3%) stddev-sans-first:13.68 20:36:59 INFO - PROCESS | 11616 | Values: 139.0 145.0 131.0 137.0 147.0 135.0 138.0 136.0 177.0 141.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:168.50 stddev:2.37 (1.4%) stddev-sans-first:2.50 20:36:59 INFO - PROCESS | 11616 | Values: 168.0 167.0 167.0 166.0 171.0 169.0 174.0 167.0 168.0 169.0 20:36:59 INFO - PROCESS | 11616 | 20:36:59 INFO - PROCESS | 11616 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:1.83 (2.9%) stddev-sans-first:1.92 20:36:59 INFO - PROCESS | 11616 | Values: 65.0 63.0 64.0 63.0 64.0 67.0 68.0 63.0 63.0 63.0 20:36:59 INFO - PROCESS | 11616 | -------- Summary: end -------- 20:36:59 INFO - PROCESS | 11616 | 20:37:00 INFO - TEST-INFO | 11616: exit 0 20:37:00 INFO - TEST-OK | kraken | took 62111ms 20:37:00 INFO - SUITE-END | took 1179s 20:37:01 INFO - Completed test suite (00:19:39) 20:37:01 INFO - javascript benchmark 20:37:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.939261214776, 3068.5704001439817, 3090.5055191169417, 3097.7831551791382, 3105.285784269618, 5238.816641417547, 5268.262443257947, 5291.497307755767, 5311.07056265154, 5314.0, 5360.410354860962, 5372.2210279509445, 5375.462453754622, 5378.354597448311, 5382.757775900084, 4840.031993601277, 4863.343448634424, 4881.8779530511665, 4902.803887844482, 4911.214205727084, 4867.1725806612785, 4948.8267910623135, 4952.158133117378, 4955.331030310916, 4957.058158949806, 4862.659613827033, 4912.950870491303, 4918.163912134928, 4939.555440010398, 4960.057589058068, 5011.824586139468, 5023.296738456619, 5032.069067222539, 5035.622328325354, 5072.949270507284, 4746.5490778376, 4772.0, 4781.521847815226, 4917.286993385975, 4930.778114984834, 5278.445763194886, 5304.867378315535, 5309.177077552986, 5325.254464374991, 5378.058839703036, 5638.689872057035, 5688.772449102031, 5694.800681976111, 5696.715164241813, 5699.800506982236, 5588.580856435784, 5629.662220266756, 5638.520725738276, 5746.770129194827, 5802.448767367136, 5343.786248550054, 5344.946550534522, 5382.300300960928, 5428.864278393072, 5431.266778984826, 5846.356900740915, 5857.355690874, 5860.0, 5861.17943487912, 5867.354590994987, 5480.287562616834, 5570.164475328733, 5624.0, 5627.662340259598, 5633.155026746021, 5609.5792815539, 5638.887222255532, 5657.490825825613, 5663.0, 5665.830025099253, 5607.775688972395, 5652.745626446737, 5656.066748986454, 5658.179563963202, 5659.179418984307, 5602.2717046783655, 5655.773769049274, 5656.038473459522, 5665.490105890407, 5708.80019199326, 4422.270325396274, 4425.800838962255, 4437.511873693891, 4463.776811159429, 4467.687261891637, 3939.940900886489, 3962.5443074046275, 3963.564007959122, 3983.64147226751, 4012.8996775080273, 5298.682079075191, 5352.732363381815, 5357.919631205535, 5472.315960504937, 5479.04116779562, 5665.178549110438, 5759.568032397587, 5762.884742305214, 5815.680137592389, 5860.736266868002, 5471.0, 5472.972635136878, 5473.151661492475, 5475.917861232085, 5484.643498172606, 4810.687305325143, 4921.458639549646, 4930.309756634074, 4933.975330123399, 4982.501749825061, 5882.411758824083, 5931.377205393458, 5981.431763982415, 5992.31088424828, 6066.848328791815, 5804.303483581997, 5804.593678442468, 5807.332156802022, 5814.127880817742, 5814.970925145347, 5990.341062483036, 5996.1005849122985, 6005.969970150121, 6012.819615411545, 6017.217761690952, 5433.212184233343, 5469.699166545878, 5522.171674248895, 5539.473749993744, 5566.081596536526, 5639.125935480007, 5689.487946084872, 5692.829215123553, 5699.971500142473, 5733.655980641175, 5530.059889818821, 5564.276644036249, 5569.944300556943, 5574.9163762542785, 5575.0, 5479.4520547944885, 5481.177823326533, 5506.339239291311, 5518.696471694096, 5531.834044978657, 5462.781488740406, 5511.338639363302, 5514.91727624078, 5515.558755299647, 5555.3611334697025, 5589.5807814413265, 5601.831945041656, 5603.80386686464, 5609.046462101371, 5609.80365687199, 5382.327209098863, 5418.322709661293, 5421.5391691706645, 5433.0, 5491.148871924698], "value": 5275.185310791015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.7666911555243, 558.9552835773136, 569.441946892046, 574.8505388598966, 575.1430368750563, 30873.536896946564, 31601.36797264056, 39834.80082599583, 40881.18237635253, 41040.79479602605, 43944.0, 43950.340744888854, 44313.556864431346, 44391.556084439144, 44473.33290000653, 8371.999999999985, 8603.31173506118, 8607.09625489324, 8607.870881936777, 8677.435966662179, 7826.295633393022, 7869.724559640414, 9943.254255930799, 10091.69724908254, 10203.183745300357, 10284.22868284878, 10338.276320657556, 10350.482475876213, 10351.223658225626, 10357.689269321894, 10287.63993260236, 10345.844812327821, 10346.844797328045, 10352.223583231287, 10361.0, 10099.39403635777, 10144.847827282596, 10156.289059765819, 10163.186945044452, 10166.237532185041, 40648.39027414591, 41015.38476922848, 41040.38439423381, 41041.79479102615, 41053.0, 3272.5091236314506, 3281.1961069538115, 3362.3779600773937, 3680.1167719747336, 3783.791891445969, 30403.69596304053, 30675.386492270252, 30938.845305773553, 31610.209744756336, 32283.19292017695, 4048.1373312243168, 4136.58634136587, 4201.663866890642, 4235.428217190671, 4242.469691288589, 223198.0, 226375.0, 227460.99999999834, 227776.0, 228984.0, 56811.0, 57854.13218801721, 57968.0, 58145.70927145337, 58156.709216454496, 59125.70437147787, 59149.0, 59264.703676482204, 59351.406485935455, 59367.10949335763, 14740.705185896222, 15034.917841842396, 15164.0, 15167.696646067017, 15172.468963586221, 10932.56269749217, 12098.455569499394, 12152.21010634306, 12159.148859579744, 12195.0, 15084.094954302776, 16537.421190258523, 16829.326826926786, 16890.662186756195, 17496.650066998587, 6226.159468471698, 6343.1436756038265, 6409.198850143732, 6446.806595802133, 6469.967650161719, 901.1754244865874, 1008.1934452438167, 1050.7320633238476, 1059.3749687684303, 1105.6959336182615, 31045.223869403446, 31048.0, 31051.689483105332, 31062.0, 31503.0, 1081.1620993729764, 1098.0940723902813, 1105.3644154611131, 1106.4744246483017, 1149.7120729747742, 15358.539243822703, 16150.254456742383, 16371.59071023234, 16378.918105409397, 16599.170041497877, 453583.0, 455477.0, 457059.0, 457290.0, 457340.0, 47970.5202947966, 48892.7555362228, 53387.0, 54472.18291725627, 54481.0, 1289.4390939941156, 1294.9805752913715, 1307.9346032698327, 1313.0611612696966, 1325.304215286982, 29599.0, 31442.37115257636, 31618.525722113725, 31723.524147138272, 31889.202769930936, 48941.2658810111, 49171.508284916694, 49314.0, 49335.50664493309, 49453.0, 403922.0, 406918.0, 407072.0, 407252.0, 407811.0, 24060.759392405853, 24741.50516989614, 26280.737192628592, 39404.408933865445, 39527.209455811295, 37807.62192378041, 38913.22173556456, 39466.605333946296, 39706.2058758829, 39934.0, 32371.0, 32908.83545582257, 32926.506102408006, 33250.50124248186, 33500.162495937795, 32211.838940805144, 32326.676733232365, 32941.50587741138, 33435.33129337448, 33658.49512257269, 34468.138296542784, 34537.65462345345, 34587.4811877817, 34639.4804077934, 35398.46902296519, 24461.38846528851, 25916.8704156478, 29810.254743631584, 29924.55113173348, 31004.449777511487, 24653.876730616234, 24747.50504989926, 24809.751902480744, 25372.619410709223, 25508.0], "value": 18810.047170265814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.83898165316447, 377.3528398796064, 381.61266314690596, 390.2974645637852, 411.7118017387829, 13864.930675346623, 17288.135593220337, 18108.63782724345, 19093.42719718407, 19097.904510477463, 17756.82243177568, 18095.276188952426, 18156.909215453936, 18330.083495825187, 18434.815651843477, 5354.2771725817, 5653.208550802891, 5671.8582035449235, 5675.716214189274, 5683.374828768832, 3984.561698213194, 4262.232798096342, 5496.148097044945, 5616.0, 5616.073347897592, 4276.722013069156, 6204.6587437690905, 6240.968795156041, 6311.905321420182, 6318.0, 6125.5712100153005, 6230.376962303779, 6281.277653069887, 6288.4026017528495, 6305.211848518935, 5561.332640083176, 5566.749496272678, 5569.220309156722, 5571.331440227158, 5572.192032155314, 21007.579848402947, 22032.559348813094, 22122.33632991013, 22293.0, 22862.885685571466, 2270.9886450567806, 2312.6531020346915, 2313.109452860661, 2370.3126093432884, 2715.7420045095882, 13531.39108740109, 14185.57443276693, 14324.283785810772, 14371.712565748627, 14750.778738318933, 1876.268255380389, 1959.6766533521952, 1980.1188471130354, 1986.5232344237425, 2022.7774944756065, 70876.93684594684, 72234.63882680605, 72683.63658181728, 73717.26282737158, 74430.0, 9860.753481163028, 9871.259655525864, 10186.694399168036, 10243.36360591994, 10478.63324783629, 14175.71648567023, 14210.442120418424, 14213.0, 14213.928930355281, 14221.644458888404, 7599.506032107895, 7805.726799562101, 7862.921370786219, 8081.919180808234, 8113.310368618733, 7400.0379950606075, 7429.4799364044, 7437.665305061285, 7628.237176282328, 7728.806779830549, 6237.594556353823, 6255.437010669061, 6282.685865706696, 6392.360763923571, 6393.520485963571, 1745.3106023120797, 1765.8322459366339, 1766.0, 1782.9554261143576, 1804.3414153833755, 919.5356345045709, 933.4259430450224, 967.0, 995.5019524492087, 1095.0691911874842, 17403.65192696139, 18240.45278641643, 18900.905495472434, 19172.424827255203, 19802.20791168366, 879.9340049496185, 920.9171174594319, 927.4620719982394, 957.2294303086082, 1048.030571721155, 9597.664081757244, 9843.163331116792, 10316.896831031743, 10346.793064138676, 10407.94796026015, 394864.0, 395394.0, 396850.0, 397628.0, 408684.0, 83274.0, 84452.57773711091, 84748.57625711955, 84758.0, 85468.57265713756, 909.4679612426672, 914.3919293669635, 938.5307346326837, 940.8306504829196, 946.4084946908182, 15276.694466110837, 15276.694466110837, 15666.686666266383, 15996.520104396886, 16251.3499460025, 36265.45601816028, 36587.81706091559, 37038.25923481569, 37519.24961500809, 37579.436308455945, 49176.0, 51550.0, 51797.0, 52144.73927630338, 53052.20421693755, 5581.7209139543675, 6438.645874476949, 6969.616671083139, 8147.75556733299, 8369.623366948625, 8052.114267430461, 10422.530986105796, 11944.581939632071, 12376.009919206623, 13093.279869607262, 6524.967375163284, 10870.293430926964, 10971.945140274247, 11296.0, 11591.304521728724, 10627.468626568796, 10650.84023739629, 11005.0, 11069.0, 11302.943485282522, 10459.94770026145, 11330.37682927447, 11383.430828458379, 11512.30926144434, 11625.128115391548, 6909.689063992032, 7121.216666166821, 7237.8914316286355, 7426.0, 7512.023436953161, 9878.259130565093, 10947.616833410792, 11112.555497779998, 11462.598809041978, 11773.470193841127], "value": 8787.72133241972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.3930791835755, 1376.9586912392629, 1377.7726675098606, 1499.940002399904, 1674.5395016370503, 7331.486795924287, 7977.760667179987, 8279.420440569154, 8296.1703829617, 8508.234258916696, 8265.752027439172, 8269.338452923766, 8336.124706905779, 8339.166083391658, 8342.708005219818, 1872.7565416495904, 2171.543975765091, 2208.9226877059305, 2209.149477451185, 2209.812165965895, 1953.716711076893, 2156.8598041127357, 2212.1704360864674, 2226.677131815886, 2229.208630936019, 2154.956900861982, 2172.0985790896757, 2176.9020394082227, 2178.6405243134864, 2180.0, 2131.1688441507827, 2142.8071473567375, 2143.142742902836, 2148.3232781673723, 2166.7183266175452, 2099.17082752312, 2109.1457959526415, 2112.714783504223, 2115.661494160927, 2129.55279391328, 8155.266026057624, 8276.0, 8280.171982801672, 8305.792355191108, 8329.708460203925, 4974.0, 5117.1556693145585, 5120.129577971754, 5123.795048198068, 5131.102057139986, 3128.482685897338, 3246.8863589774246, 3321.684439978198, 3334.3664703706218, 3365.528825964367, 1013.4729940430934, 1082.7022568793566, 1129.7006293332274, 1131.2420678145663, 1132.2413982631574, 11495.310281383145, 11522.76954460906, 11540.422978851107, 11543.422828858524, 11544.653660390202, 4488.102379524108, 4558.156741002858, 4629.976850115728, 4661.650376221797, 4667.696599721007, 9188.0, 9206.723798286062, 9270.44377337362, 9289.16397524226, 9325.440473571607, 5163.251328557338, 5169.586433085344, 5173.637845350864, 5175.611829112831, 5176.7411629418375, 4451.643868490513, 4532.864014079583, 4574.771261436915, 4823.0, 4830.492798256132, 3570.9285814283567, 3640.344737947195, 3652.123490362294, 3669.743117981716, 3677.3564626190846, 1124.5839039555417, 1148.9540418383338, 1151.3897634253858, 1158.965231043053, 1165.4813607944552, 728.8287252495659, 844.6368061733514, 845.5222799118478, 854.7008547008497, 928.3733479901175, 5204.9739751301, 5365.9731701342025, 5409.6213265071065, 5583.274174357389, 5635.464630860061, 419.57832378459455, 420.7265277569604, 433.99349009764876, 438.27027998382334, 446.2881703682621, 3534.8939531814085, 3590.2101537661674, 3596.0871693928, 3650.233450975272, 3689.760165589228, 9787.217022638171, 10106.494675266355, 10214.285000050073, 10230.0, 10270.743231419274, 8877.822443551093, 9248.213901818286, 9382.85925711115, 10163.237757168243, 10169.13562347194, 7605.23947605235, 7836.138024817265, 7844.568548729874, 7850.0, 7861.331786798186, 5497.202905578589, 5555.8888822224135, 5629.6903670298525, 5648.152777083306, 5868.354481007001, 9361.157495825137, 9409.623615055321, 9426.387284826464, 9439.622415103318, 9521.761955951157, 8371.790705232173, 8904.376693631642, 9327.953360233156, 9329.58016889228, 9601.231901448007, 6706.094677218513, 7077.504574679929, 7087.362137407658, 7156.320149585781, 7375.225601311785, 7851.725189618336, 7898.723544675909, 7962.601869906365, 7986.361091112581, 8058.556779377191, 7194.4244460442, 7222.819429514304, 7223.783286501413, 7235.782926512213, 7273.272672732684, 6883.931160688529, 6923.792286231421, 7162.355388015104, 7186.1376634804155, 7366.337029667356, 6375.6174629522375, 6751.493637977073, 6849.075374824335, 6853.691583878837, 6854.485913556404, 4489.124620698933, 4535.0, 4581.0, 4705.12955103307, 4811.879703007453, 4653.976730116327, 4661.114388266218, 4795.472498025145, 4798.23228283473, 4887.0714564232685], "value": 4235.770049097237, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.5319644052054, 376.4860964783071, 376.94157405602135, 379.26801273542054, 385.70686278428406, 5162.0, 5228.451012643674, 5229.189475631274, 5241.475852414756, 5268.235141227693, 5162.199859021848, 5162.561182299509, 5167.819126330579, 5170.560502357304, 5174.223866420039, 3684.5762737285154, 3936.1537269487053, 4054.3107671695884, 4167.895507690457, 4183.686223533247, 4095.897602559945, 4112.814923328442, 4122.083231297446, 4138.917221655565, 4147.398627199054, 4073.124278280169, 4090.5909409059154, 4093.099518106012, 4100.528439229497, 4129.194807012634, 3991.7405368651234, 4070.5725898780497, 4126.42230087788, 4145.31602285624, 4156.542780294165, 3635.1820840310984, 3651.434027725707, 3659.451082337644, 3704.240630670706, 3710.424884142962, 4973.676711013773, 4984.255510571307, 4992.725400102993, 5006.69959802413, 5034.496550344973, 4573.63410927125, 4664.113818374498, 4671.649626278008, 4685.1800934836265, 4706.599939005188, 5323.920141197885, 5358.196270559409, 5363.704996225206, 5363.812266570651, 5368.892622147574, 4058.6347228749555, 4068.776217308047, 4073.4500842386196, 4085.387191921206, 4101.794910254475, 5284.313039304904, 5297.913927644823, 5460.372057213432, 5501.092319767234, 5568.3596386415675, 4142.2751018572235, 4161.209370219649, 4164.68764842638, 4177.310743727251, 4190.0, 4244.830206791756, 4254.914901701949, 4261.509926358446, 4267.637250833652, 4274.551172126944, 4393.626541743924, 4614.062093920561, 4761.309610106515, 4767.833125840579, 4799.688020278741, 5429.158480435539, 5432.076546986943, 5442.537384322298, 5444.754986025639, 5451.318585176853, 1364.0587994283912, 1365.8322134574994, 1371.8010888421122, 1375.2848518770384, 1377.0085538412327, 911.0722770916489, 936.1247233836249, 940.0, 943.8395472769646, 966.6568368229318, 5105.259737338065, 5148.510891465305, 5149.716765577929, 5155.510226528474, 5165.715885626327, 5379.381371142291, 5429.864253393696, 5443.673379597237, 5463.328853829918, 5494.2857428534035, 4975.255755726354, 4983.4302194808515, 5103.438621751604, 5155.226715992631, 5161.270974223602, 2818.436312737461, 2839.6734375547076, 2857.457083154194, 2861.914142575726, 2863.226928729273, 5515.393306736256, 5568.9443105568425, 5575.961101199856, 5579.38626751057, 5600.299962504687, 5351.331083614548, 5391.495527906892, 5618.6628802272, 5662.68855212959, 5672.801451949162, 5717.056685646905, 5756.913646295309, 5766.722144752883, 5771.538276937918, 5772.624779389326, 5513.862153446035, 5566.666000040011, 5577.191307260506, 5606.355269143937, 5634.183043458594, 5529.419410961791, 5561.694106824163, 5561.721913904208, 5563.970665426909, 5567.832965011056, 5517.006938751063, 5627.803026894039, 5635.436456354331, 5783.652980821164, 5785.27684039495, 4020.276350256982, 4023.195360927885, 4049.372347286175, 4054.9797251013556, 4064.8577299794365, 5351.571874249973, 5607.850390669984, 5643.068893632505, 5652.293463317085, 5659.462351076641, 5429.837104886859, 5434.673919564839, 5452.727363631882, 5463.0, 5475.318602594724, 5438.4561543846885, 5440.510354067995, 5451.563874890078, 5471.945280547144, 5473.945260547343, 5147.2279158126585, 5346.97326513365, 5379.19312103172, 5399.487048730364, 5401.243825864303, 5451.0921177587525, 5461.934922690038, 5481.945180548303, 5493.615446918678, 5500.50495455411, 5349.111479801019, 5358.490943360374, 5358.517733404013, 5369.865753356197, 5375.838724838261], "value": 4175.440511205125, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.1168821440878, 698.975535856245, 709.3722055980462, 720.6828995242093, 745.8881167824826, 15307.464238751645, 16613.91693041533, 16619.08595027273, 16640.58398540037, 16756.32974681013, 14878.404863805461, 15093.471728489505, 15258.542243732678, 15266.084034957883, 15287.388504459808, 788.9132195458509, 798.9440739148262, 806.31060443321, 806.6047636658025, 807.2452257139594, 748.9887651685202, 749.5203070035182, 749.5352881213628, 753.3107206905702, 754.5472716370189, 832.1013305629905, 832.9625166867505, 833.9166083391673, 834.253343257784, 834.3783881008657, 821.9260266575977, 825.471698113205, 826.0, 829.1708291708292, 831.0, 604.2537466229203, 606.8937935861206, 606.9817905462843, 609.9481544068759, 611.2298503885137, 13277.46890124394, 13601.183928964294, 13646.863531364757, 14187.78718319226, 14312.713745725026, 12449.688757781038, 13038.543650972266, 13104.2137471752, 13120.146276265448, 13201.735965280737, 10752.784944301071, 10880.510377033053, 10912.454377281183, 11237.213395062348, 11296.0, 3574.249407624376, 3609.2420591675777, 3650.3246899323444, 3804.1630841214887, 3806.828692708807, 72149.27850721478, 74797.25202747957, 75740.24259757387, 75853.62073189655, 76657.0, 9609.807803843883, 9751.21990240779, 9786.902130978599, 9891.851622225673, 9906.0, 18948.905255473634, 19765.505862353268, 19931.501712457015, 19951.800481995284, 19954.30159944395, 8325.417220794607, 8355.791105222417, 8383.622736976851, 8525.914740852511, 8649.827003459895, 4505.414296141481, 4508.278675411918, 4535.841245556456, 4674.368960190399, 4702.106599746037, 3520.067182196669, 3589.3180295743723, 3604.098975256186, 3604.116991337139, 3645.54430696163, 613.1232337756961, 614.2475467552213, 615.2217444932164, 634.4987459906714, 635.6726285962641, 644.560339116442, 648.4585371214994, 690.1890278922247, 719.7876626395226, 727.1201845766682, 9827.150126463246, 9902.653407130716, 10062.547185376676, 10091.394516329045, 10130.138938190335, 700.0786105219426, 704.4434896431864, 718.8490417012381, 722.7000794670258, 734.7795661301589, 4463.754493502888, 4644.767761611906, 4776.817944185787, 4897.657163998557, 4944.8763780905765, 62612.0, 78114.6094269525, 78588.0, 81129.0, 81837.59081204556, 66690.66654666695, 67840.32159678439, 68256.6587167061, 68354.65822670855, 68523.0, 61618.38381616216, 62085.689571551855, 62622.68688656619, 63096.0, 64296.357036429974, 9211.124943130391, 9447.0, 9585.856212156683, 9666.420014799134, 9677.854832177663, 42984.57015429805, 43459.78270108629, 43609.12781744411, 44589.0, 46097.53902460932, 53789.46210538001, 55465.0, 59450.70274648599, 60820.0, 62305.0, 11335.0, 11402.942985285352, 11781.293122412682, 11852.881471185177, 11921.165518413627, 14441.0, 14634.634134146732, 14793.92603036978, 14893.925530372711, 15055.623609409853, 14272.21502817355, 14372.49696260626, 14541.563753087425, 14699.338529765972, 14799.0, 13849.16904985704, 14208.857911420753, 14309.21299328547, 14826.40694372213, 14889.478868239992, 13875.167489950636, 14154.646133846736, 14170.929145354206, 14713.117212967256, 14836.629084272548, 11336.94331528337, 11592.188546801643, 11696.649100526998, 11739.954341306156, 11827.704307392383, 10251.48742562854, 11622.6513204604, 11844.822327664919, 12062.577809776616, 12251.0], "value": 7139.074578973813, "unit": "score"}], "name": "dromaeo_css", "value": 6923.16021178149, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 111.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 124.0, 155.0, 130.0, 127.0, 121.0, 125.0, 150.0, 122.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 163.0, 161.0, 163.0, 164.0, 163.0, 162.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 107.0, 83.0, 76.0, 77.0, 76.0, 90.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 113.0, 85.0, 84.0, 84.0, 102.0, 84.0, 84.0, 107.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 128.0, 127.0, 127.0, 126.0, 127.0, 127.0, 127.0, 126.0], "value": 126.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 64.0, 53.0, 52.0, 55.0, 53.0, 53.0, 53.0, 54.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 81.0, 81.0, 81.0, 82.0, 82.0, 85.0, 81.0, 79.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 145.0, 131.0, 137.0, 147.0, 135.0, 138.0, 136.0, 177.0, 141.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 167.0, 166.0, 171.0, 169.0, 174.0, 167.0, 168.0, 169.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 64.0, 67.0, 68.0, 63.0, 63.0, 63.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1525.8999999999999, "alertThreshold": 2.0}]} 20:37:01 INFO - Return code: 0 20:37:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:37:01 INFO - # TBPL SUCCESS # 20:37:01 INFO - Running post-action listener: _resource_record_post_action 20:37:01 INFO - [mozharness: 2016-12-15 04:37:01.293033Z] Finished run-tests step (success) 20:37:01 INFO - Running post-run listener: _resource_record_post_run 20:37:01 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403611648; Read time: 12; Write time: 276984 20:37:01 INFO - TinderboxPrint: CPU usage
13.2% 20:37:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:37:01 INFO - TinderboxPrint: I/O write bytes / time
403,611,648 / 276,984 20:37:01 INFO - TinderboxPrint: CPU idle
8,292.3 (86.8%) 20:37:01 INFO - TinderboxPrint: CPU user
1,207.0 (12.6%) 20:37:01 INFO - TinderboxPrint: Swap in / out
0 / 0 20:37:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103993344; Read time: 0; Write time: 70692 20:37:01 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288366592; Read time: 0; Write time: 204188 20:37:01 INFO - Running post-run listener: _upload_blobber_files 20:37:01 INFO - Blob upload gear active. 20:37:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:37:01 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 20:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:37:02 INFO - (blobuploader) - INFO - Open directory for files ... 20:37:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:37:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:37:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:03 INFO - (blobuploader) - INFO - Done attempting. 20:37:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:37:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:37:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:03 INFO - (blobuploader) - INFO - Done attempting. 20:37:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:37:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:37:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:07 INFO - (blobuploader) - INFO - Done attempting. 20:37:07 INFO - (blobuploader) - INFO - Iteration through files over. 20:37:07 INFO - Return code: 0 20:37:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:37:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:37:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a91912ca625b9e49549bed2488ffd296953faf932dcb2b9fe59043507ef7e1965d082fa63b777d6a3af4e689ad962688d6233d6ad9d0be0f8ed1577881fc8ccf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea6c612ad29fe6b4448a38cc5ba430f26fb3c46d4de3b0338278035bc0258911d312b68c7ccfbbff53fbba0cfd7f0c5f8ce354f11944488a40c351ac6c38731d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/191d3cdce23cf8cbda1b7b04425ff42486faa45043fe7e30530cec291a607c2b65f56417552be7a3748b654cf8703c723557b3f837bd59d63d440e5664e09ada"} 20:37:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:37:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:37:07 INFO - Contents: 20:37:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a91912ca625b9e49549bed2488ffd296953faf932dcb2b9fe59043507ef7e1965d082fa63b777d6a3af4e689ad962688d6233d6ad9d0be0f8ed1577881fc8ccf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea6c612ad29fe6b4448a38cc5ba430f26fb3c46d4de3b0338278035bc0258911d312b68c7ccfbbff53fbba0cfd7f0c5f8ce354f11944488a40c351ac6c38731d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/191d3cdce23cf8cbda1b7b04425ff42486faa45043fe7e30530cec291a607c2b65f56417552be7a3748b654cf8703c723557b3f837bd59d63d440e5664e09ada"} 20:37:07 INFO - Running post-run listener: copy_logs_to_upload_dir 20:37:07 INFO - Copying logs to upload dir... 20:37:07 INFO - mkdir: /builds/slave/test/build/upload/logs 20:37:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.834854 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-12-14 20:37:06.570564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 20:37:06.575952) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a91912ca625b9e49549bed2488ffd296953faf932dcb2b9fe59043507ef7e1965d082fa63b777d6a3af4e689ad962688d6233d6ad9d0be0f8ed1577881fc8ccf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea6c612ad29fe6b4448a38cc5ba430f26fb3c46d4de3b0338278035bc0258911d312b68c7ccfbbff53fbba0cfd7f0c5f8ce354f11944488a40c351ac6c38731d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/191d3cdce23cf8cbda1b7b04425ff42486faa45043fe7e30530cec291a607c2b65f56417552be7a3748b654cf8703c723557b3f837bd59d63d440e5664e09ada"} build_url:https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011884 build_url: 'https://queue.taskcluster.net/v1/task/cP3CKblvTGGcVo09t3AydQ/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/Mozilla-Inbound/sha512/a91912ca625b9e49549bed2488ffd296953faf932dcb2b9fe59043507ef7e1965d082fa63b777d6a3af4e689ad962688d6233d6ad9d0be0f8ed1577881fc8ccf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ea6c612ad29fe6b4448a38cc5ba430f26fb3c46d4de3b0338278035bc0258911d312b68c7ccfbbff53fbba0cfd7f0c5f8ce354f11944488a40c351ac6c38731d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/191d3cdce23cf8cbda1b7b04425ff42486faa45043fe7e30530cec291a607c2b65f56417552be7a3748b654cf8703c723557b3f837bd59d63d440e5664e09ada"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 20:37:06.601708) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:37:06.602011) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1481775071.122850-276037870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:37:06.685900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 20:37:06.686271) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 20:37:06.686774) ========= ========= Total master_lag: 0.17 =========