builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1474419991.91 results: success (0) buildid: 20160920153005 builduid: b4f68b38216a46e19ebfdc6a6a55f779 revision: 005bf983f9e34c0e905830bddb4e54e9a1e1b7c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:31.908307) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:31.908821) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:31.909153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:31.951752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:31.952081) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-20 18:06:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-09-20 18:06:32 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:32.073128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:32.073459) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020590 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:32.122746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-20 18:06:32.123138) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 005bf983f9e34c0e905830bddb4e54e9a1e1b7c1 --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 005bf983f9e34c0e905830bddb4e54e9a1e1b7c1 --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=82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-20 18:06:32,312 truncating revision to first 12 chars 2016-09-20 18:06:32,313 Setting DEBUG logging. 2016-09-20 18:06:32,313 attempt 1/10 2016-09-20 18:06:32,313 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/005bf983f9e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-20 18:06:33,632 unpacking tar archive at: mozilla-inbound-005bf983f9e3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.644940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-20 18:06:33.784675) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:33.785461) ========= script_repo_revision: 005bf983f9e34c0e905830bddb4e54e9a1e1b7c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:33.786366) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:33.786923) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 18:06:33.798020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-20 18:06:33.798381) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:06:34 INFO - MultiFileLogger online at 20160920 18:06:34 in /builds/slave/test 18:06:34 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 18:06:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:06:34 INFO - {'append_to_log': False, 18:06:34 INFO - 'base_work_dir': '/builds/slave/test', 18:06:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:06:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:06:34 INFO - 'branch': 'Mozilla-Inbound', 18:06:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:06:34 INFO - 'config_files': ('talos/linux_config.py',), 18:06:34 INFO - 'default_actions': ('clobber', 18:06:34 INFO - 'read-buildbot-config', 18:06:34 INFO - 'download-and-extract', 18:06:34 INFO - 'populate-webroot', 18:06:34 INFO - 'create-virtualenv', 18:06:34 INFO - 'install', 18:06:34 INFO - 'run-tests'), 18:06:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:06:34 INFO - 'download_minidump_stackwalk': True, 18:06:34 INFO - 'download_symbols': 'ondemand', 18:06:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:06:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:06:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:06:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:06:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:06:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:06:34 INFO - 'installer_path': 'installer.exe', 18:06:34 INFO - 'log_level': 'info', 18:06:34 INFO - 'log_name': 'talos', 18:06:34 INFO - 'log_to_console': True, 18:06:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:06:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:06:34 INFO - 'opt_config_files': (), 18:06:34 INFO - 'pip_index': False, 18:06:34 INFO - 'sps_profile': False, 18:06:34 INFO - 'sps_profile_interval': 0, 18:06:34 INFO - 'suite': 'dromaeojs', 18:06:34 INFO - 'system_bits': '32', 18:06:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:06:34 INFO - 'title': 'talos-linux64-ix-066', 18:06:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:06:34 INFO - 'use_talos_json': True, 18:06:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:06:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:06:34 INFO - 'work_dir': 'build'} 18:06:34 INFO - [mozharness: 2016-09-21 01:06:34.080816Z] Running clobber step. 18:06:34 INFO - Running pre-action listener: _resource_record_pre_action 18:06:34 INFO - Running main action method: clobber 18:06:34 INFO - rmtree: /builds/slave/test/build 18:06:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:06:34 INFO - Running post-action listener: _resource_record_post_action 18:06:34 INFO - [mozharness: 2016-09-21 01:06:34.527020Z] Finished clobber step (success) 18:06:34 INFO - [mozharness: 2016-09-21 01:06:34.527121Z] Running read-buildbot-config step. 18:06:34 INFO - Running pre-action listener: _resource_record_pre_action 18:06:34 INFO - Running main action method: read_buildbot_config 18:06:34 INFO - Using buildbot properties: 18:06:34 INFO - { 18:06:34 INFO - "project": "", 18:06:34 INFO - "product": "firefox", 18:06:34 INFO - "script_repo_revision": "production", 18:06:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:06:34 INFO - "repository": "", 18:06:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:06:34 INFO - "buildid": "20160920153005", 18:06:34 INFO - "pgo_build": "True", 18:06:34 INFO - "basedir": "/builds/slave/test", 18:06:34 INFO - "buildnumber": 1570, 18:06:34 INFO - "slavename": "talos-linux64-ix-066", 18:06:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:06:34 INFO - "platform": "ubuntu64_hw", 18:06:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:06:34 INFO - "branch": "mozilla-inbound", 18:06:34 INFO - "repo_path": "integration/mozilla-inbound", 18:06:34 INFO - "revision": "005bf983f9e34c0e905830bddb4e54e9a1e1b7c1", 18:06:34 INFO - "stage_platform": "linux64-pgo", 18:06:34 INFO - "builduid": "b4f68b38216a46e19ebfdc6a6a55f779", 18:06:34 INFO - "slavebuilddir": "test" 18:06:34 INFO - } 18:06:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:06:34 INFO - Running post-action listener: _resource_record_post_action 18:06:34 INFO - [mozharness: 2016-09-21 01:06:34.529570Z] Finished read-buildbot-config step (success) 18:06:34 INFO - [mozharness: 2016-09-21 01:06:34.529658Z] Running download-and-extract step. 18:06:34 INFO - Running pre-action listener: _resource_record_pre_action 18:06:34 INFO - Running main action method: download_and_extract 18:06:34 INFO - mkdir: /builds/slave/test/build/tests 18:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:34 INFO - trying https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:06:34 INFO - Downloading https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:06:35 INFO - Downloaded 1361 bytes. 18:06:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:06:35 INFO - Using the following test package requirements: 18:06:35 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:06:35 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:06:35 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:06:35 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:35 INFO - u'jsshell-linux-x86_64.zip'], 18:06:35 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:06:35 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:06:35 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:06:35 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:06:35 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:06:35 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:06:35 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:06:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:06:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:06:35 INFO - Fetch https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:06:35 INFO - Expected file size: 21942653 18:06:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:06:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:06:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:06:40 INFO - Fetch https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:06:40 INFO - Expected file size: 21942653 18:06:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:06:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:06:45 INFO - Fetch https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:06:45 INFO - Expected file size: 14414059 18:06:46 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')]} 18:06:46 INFO - trying https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:06:46 INFO - Downloading https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:06:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:06:47 INFO - Downloaded 59481257 bytes. 18:06:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:06:47 INFO - mkdir: /builds/slave/test/properties 18:06:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:06:47 INFO - Writing to file /builds/slave/test/properties/build_url 18:06:47 INFO - Contents: 18:06:47 INFO - build_url:https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:06:48 INFO - Running post-action listener: _resource_record_post_action 18:06:48 INFO - Running post-action listener: set_extra_try_arguments 18:06:48 INFO - [mozharness: 2016-09-21 01:06:48.222414Z] Finished download-and-extract step (success) 18:06:48 INFO - [mozharness: 2016-09-21 01:06:48.222650Z] Running populate-webroot step. 18:06:48 INFO - Running pre-action listener: _resource_record_pre_action 18:06:48 INFO - Running main action method: populate_webroot 18:06:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:06:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:06:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:06:48 INFO - '--tppagecycles', 18:06:48 INFO - '7'], 18:06:48 INFO - 'tests': ['tsvgm']}}, 18:06:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:06:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:06:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:06:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:06:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:48 INFO - 'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:48 INFO - 'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['damp', 'tps']}, 18:06:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:48 INFO - 'tests': ['damp', 'tps']}, 18:06:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['dromaeo_dom']}, 18:06:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:06:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['basic_compositor_video']}, 18:06:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:06:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['a11yr', 18:06:48 INFO - 'ts_paint', 18:06:48 INFO - 'tpaint', 18:06:48 INFO - 'sessionrestore', 18:06:48 INFO - 'sessionrestore_no_auto_restore', 18:06:48 INFO - 'tabpaint']}, 18:06:48 INFO - 'other-e10s': {'tests': ['a11yr', 18:06:48 INFO - 'ts_paint', 18:06:48 INFO - 'tpaint', 18:06:48 INFO - 'sessionrestore', 18:06:48 INFO - 'sessionrestore_no_auto_restore', 18:06:48 INFO - 'tabpaint']}, 18:06:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:06:48 INFO - 'ts_paint', 18:06:48 INFO - 'tpaint', 18:06:48 INFO - 'sessionrestore', 18:06:48 INFO - 'sessionrestore_no_auto_restore', 18:06:48 INFO - 'tabpaint']}, 18:06:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:06:48 INFO - 'ts_paint', 18:06:48 INFO - 'tpaint', 18:06:48 INFO - 'sessionrestore', 18:06:48 INFO - 'sessionrestore_no_auto_restore', 18:06:48 INFO - 'tabpaint']}, 18:06:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['a11yr', 18:06:48 INFO - 'ts_paint', 18:06:48 INFO - 'tpaint', 18:06:48 INFO - 'sessionrestore', 18:06:48 INFO - 'sessionrestore_no_auto_restore', 18:06:48 INFO - 'tabpaint']}, 18:06:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['a11yr', 18:06:48 INFO - 'ts_paint', 18:06:48 INFO - 'tpaint', 18:06:48 INFO - 'sessionrestore', 18:06:48 INFO - 'sessionrestore_no_auto_restore', 18:06:48 INFO - 'tabpaint']}, 18:06:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['tsvgx', 18:06:48 INFO - 'tsvgr_opacity', 18:06:48 INFO - 'tart', 18:06:48 INFO - 'tscrollx', 18:06:48 INFO - 'cart']}, 18:06:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:06:48 INFO - 'tsvgr_opacity', 18:06:48 INFO - 'tart', 18:06:48 INFO - 'tscrollx', 18:06:48 INFO - 'cart']}, 18:06:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:48 INFO - 'talos_options': ['--disable-e10s'], 18:06:48 INFO - 'tests': ['tp5o']}, 18:06:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:48 INFO - 'tests': ['tp5o']}, 18:06:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:48 INFO - 'talos_options': ['--disable-e10s', 18:06:48 INFO - '--xperf_path', 18:06:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:48 INFO - 'tests': ['tp5n']}, 18:06:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:48 INFO - 'talos_options': ['--xperf_path', 18:06:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:48 INFO - 'tests': ['tp5n']}}, 18:06:48 INFO - 'talos.zip': {'path': '', 18:06:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:06:48 INFO - Running post-action listener: _resource_record_post_action 18:06:48 INFO - [mozharness: 2016-09-21 01:06:48.245887Z] Finished populate-webroot step (success) 18:06:48 INFO - [mozharness: 2016-09-21 01:06:48.245975Z] Running create-virtualenv step. 18:06:48 INFO - Running pre-action listener: _resource_record_pre_action 18:06:48 INFO - Running main action method: create_virtualenv 18:06:48 INFO - Creating virtualenv /builds/slave/test/build/venv 18:06:48 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 18:06:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:06:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:06:48 INFO - Using real prefix '/usr' 18:06:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:06:48 INFO - Installing distribute.............................................................................................................................................................................................done. 18:06:50 INFO - Installing pip.................done. 18:06:50 INFO - Return code: 0 18:06:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:06:50 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')]} 18:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:50 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')]} 18:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:50 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 0x7f72f3320f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', '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 18:06:50 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 18:06:50 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 18:06:50 INFO - Using env: {'DISPLAY': ':0', 18:06:50 INFO - 'HOME': '/home/cltbld', 18:06:50 INFO - 'LANG': 'en_US.UTF-8', 18:06:50 INFO - 'LANGUAGE': 'en_US:en', 18:06:50 INFO - 'LOGNAME': 'cltbld', 18:06:50 INFO - 'MAIL': '/var/mail/cltbld', 18:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:50 INFO - 'MOZ_NO_REMOTE': '1', 18:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:50 INFO - 'NO_EM_RESTART': '1', 18:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:50 INFO - 'PWD': '/builds/slave/test', 18:06:50 INFO - 'SHELL': '/bin/bash', 18:06:50 INFO - 'SHLVL': '1', 18:06:50 INFO - 'TERM': 'linux', 18:06:50 INFO - 'TMOUT': '86400', 18:06:50 INFO - 'USER': 'cltbld', 18:06:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:50 INFO - '_': '/tools/buildbot/bin/python'} 18:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:51 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 18:06:51 INFO - Cleaning up... 18:06:51 INFO - Return code: 0 18:06:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:51 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 0x7f72f3320f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', '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 18:06:51 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 18:06:51 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 18:06:51 INFO - Using env: {'DISPLAY': ':0', 18:06:51 INFO - 'HOME': '/home/cltbld', 18:06:51 INFO - 'LANG': 'en_US.UTF-8', 18:06:51 INFO - 'LANGUAGE': 'en_US:en', 18:06:51 INFO - 'LOGNAME': 'cltbld', 18:06:51 INFO - 'MAIL': '/var/mail/cltbld', 18:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:51 INFO - 'MOZ_NO_REMOTE': '1', 18:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:51 INFO - 'NO_EM_RESTART': '1', 18:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:51 INFO - 'PWD': '/builds/slave/test', 18:06:51 INFO - 'SHELL': '/bin/bash', 18:06:51 INFO - 'SHLVL': '1', 18:06:51 INFO - 'TERM': 'linux', 18:06:51 INFO - 'TMOUT': '86400', 18:06:51 INFO - 'USER': 'cltbld', 18:06:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:51 INFO - '_': '/tools/buildbot/bin/python'} 18:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:51 INFO - Downloading/unpacking psutil>=3.1.1 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:06:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:53 INFO - Installing collected packages: psutil 18:06:53 INFO - Running setup.py install for psutil 18:06:53 INFO - building 'psutil._psutil_linux' extension 18:06:53 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 18:06:53 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 18:06:53 INFO - building 'psutil._psutil_posix' extension 18:06:53 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 18:06:53 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 18:06:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:53 INFO - Successfully installed psutil 18:06:53 INFO - Cleaning up... 18:06:53 INFO - Return code: 0 18:06:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72f3320f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', '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 18:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:06:53 INFO - Using env: {'DISPLAY': ':0', 18:06:53 INFO - 'HOME': '/home/cltbld', 18:06:53 INFO - 'LANG': 'en_US.UTF-8', 18:06:53 INFO - 'LANGUAGE': 'en_US:en', 18:06:53 INFO - 'LOGNAME': 'cltbld', 18:06:53 INFO - 'MAIL': '/var/mail/cltbld', 18:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:53 INFO - 'MOZ_NO_REMOTE': '1', 18:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:53 INFO - 'NO_EM_RESTART': '1', 18:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:53 INFO - 'PWD': '/builds/slave/test', 18:06:53 INFO - 'SHELL': '/bin/bash', 18:06:53 INFO - 'SHLVL': '1', 18:06:53 INFO - 'TERM': 'linux', 18:06:53 INFO - 'TMOUT': '86400', 18:06:53 INFO - 'USER': 'cltbld', 18:06:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:53 INFO - '_': '/tools/buildbot/bin/python'} 18:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:06:56 INFO - Installing collected packages: mozsystemmonitor 18:06:56 INFO - Running setup.py install for mozsystemmonitor 18:06:56 INFO - Successfully installed mozsystemmonitor 18:06:56 INFO - Cleaning up... 18:06:56 INFO - Return code: 0 18:06:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:06: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')]} 18:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06: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')]} 18:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f72f3320f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', '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 18:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:06:56 INFO - Using env: {'DISPLAY': ':0', 18:06:56 INFO - 'HOME': '/home/cltbld', 18:06:56 INFO - 'LANG': 'en_US.UTF-8', 18:06:56 INFO - 'LANGUAGE': 'en_US:en', 18:06:56 INFO - 'LOGNAME': 'cltbld', 18:06:56 INFO - 'MAIL': '/var/mail/cltbld', 18:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:56 INFO - 'MOZ_NO_REMOTE': '1', 18:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:56 INFO - 'NO_EM_RESTART': '1', 18:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:56 INFO - 'PWD': '/builds/slave/test', 18:06:56 INFO - 'SHELL': '/bin/bash', 18:06:56 INFO - 'SHLVL': '1', 18:06:56 INFO - 'TERM': 'linux', 18:06:56 INFO - 'TMOUT': '86400', 18:06:56 INFO - 'USER': 'cltbld', 18:06:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:56 INFO - '_': '/tools/buildbot/bin/python'} 18:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:56 INFO - Downloading/unpacking jsonschema==2.5.1 18:06:56 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 18:06:56 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 18:06:56 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 18:06:56 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 18:06:56 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 18:06:56 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 18:06:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:06:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:06:58 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 18:06:58 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 18:06:58 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 18:06:58 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 18:06:58 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 18:06:58 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 18:06:58 INFO - Downloading functools32-3.2.3-2.tar.gz 18:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:06:58 INFO - warning: no files found matching '*.txt' 18:06:58 INFO - no previously-included directories found matching 'build' 18:06:58 INFO - no previously-included directories found matching 'dist' 18:06:58 INFO - no previously-included directories found matching '.git*' 18:06:58 INFO - Installing collected packages: jsonschema, functools32 18:06:58 INFO - Running setup.py install for functools32 18:06:58 INFO - warning: no files found matching '*.txt' 18:06:58 INFO - no previously-included directories found matching 'build' 18:06:58 INFO - no previously-included directories found matching 'dist' 18:06:58 INFO - no previously-included directories found matching '.git*' 18:06:58 INFO - Successfully installed jsonschema functools32 18:06:58 INFO - Cleaning up... 18:06:58 INFO - Return code: 0 18:06:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:06:58 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')]} 18:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:58 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')]} 18:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:58 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 0x7f72f3320f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', '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 18:06:58 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 18:06:58 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 18:06:58 INFO - Using env: {'DISPLAY': ':0', 18:06:58 INFO - 'HOME': '/home/cltbld', 18:06:58 INFO - 'LANG': 'en_US.UTF-8', 18:06:58 INFO - 'LANGUAGE': 'en_US:en', 18:06:58 INFO - 'LOGNAME': 'cltbld', 18:06:58 INFO - 'MAIL': '/var/mail/cltbld', 18:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:58 INFO - 'MOZ_NO_REMOTE': '1', 18:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:58 INFO - 'NO_EM_RESTART': '1', 18:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:58 INFO - 'PWD': '/builds/slave/test', 18:06:58 INFO - 'SHELL': '/bin/bash', 18:06:58 INFO - 'SHLVL': '1', 18:06:58 INFO - 'TERM': 'linux', 18:06:58 INFO - 'TMOUT': '86400', 18:06:58 INFO - 'USER': 'cltbld', 18:06:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:58 INFO - '_': '/tools/buildbot/bin/python'} 18:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:06:58 INFO - Cleaning up... 18:06:58 INFO - Return code: 0 18:06:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:06:58 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')]} 18:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:58 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')]} 18:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:58 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 0x7f72f3320f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', '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 18:06:58 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 18:06:58 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 18:06:58 INFO - Using env: {'DISPLAY': ':0', 18:06:58 INFO - 'HOME': '/home/cltbld', 18:06:58 INFO - 'LANG': 'en_US.UTF-8', 18:06:58 INFO - 'LANGUAGE': 'en_US:en', 18:06:58 INFO - 'LOGNAME': 'cltbld', 18:06:58 INFO - 'MAIL': '/var/mail/cltbld', 18:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:58 INFO - 'MOZ_NO_REMOTE': '1', 18:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:58 INFO - 'NO_EM_RESTART': '1', 18:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:58 INFO - 'PWD': '/builds/slave/test', 18:06:58 INFO - 'SHELL': '/bin/bash', 18:06:58 INFO - 'SHLVL': '1', 18:06:58 INFO - 'TERM': 'linux', 18:06:58 INFO - 'TMOUT': '86400', 18:06:58 INFO - 'USER': 'cltbld', 18:06:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:58 INFO - '_': '/tools/buildbot/bin/python'} 18:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:59 INFO - Downloading/unpacking blobuploader==1.2.4 18:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:01 INFO - Downloading blobuploader-1.2.4.tar.gz 18:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:07:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:07:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:01 INFO - Downloading docopt-0.6.1.tar.gz 18:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:07:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:07:01 INFO - Running setup.py install for blobuploader 18:07:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:07:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:07:01 INFO - Running setup.py install for requests 18:07:02 INFO - Running setup.py install for docopt 18:07:02 INFO - Successfully installed blobuploader requests docopt 18:07:02 INFO - Cleaning up... 18:07:02 INFO - Return code: 0 18:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:02 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 0x7f72f3320f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', '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 18:07:02 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 18:07:02 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 18:07:02 INFO - Using env: {'DISPLAY': ':0', 18:07:02 INFO - 'HOME': '/home/cltbld', 18:07:02 INFO - 'LANG': 'en_US.UTF-8', 18:07:02 INFO - 'LANGUAGE': 'en_US:en', 18:07:02 INFO - 'LOGNAME': 'cltbld', 18:07:02 INFO - 'MAIL': '/var/mail/cltbld', 18:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:02 INFO - 'MOZ_NO_REMOTE': '1', 18:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:02 INFO - 'NO_EM_RESTART': '1', 18:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:02 INFO - 'PWD': '/builds/slave/test', 18:07:02 INFO - 'SHELL': '/bin/bash', 18:07:02 INFO - 'SHLVL': '1', 18:07:02 INFO - 'TERM': 'linux', 18:07:02 INFO - 'TMOUT': '86400', 18:07:02 INFO - 'USER': 'cltbld', 18:07:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:02 INFO - '_': '/tools/buildbot/bin/python'} 18:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:07:02 INFO - Running setup.py (path:/tmp/pip-jDVswo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:07:02 INFO - Running setup.py (path:/tmp/pip-KMrdk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:07:02 INFO - Running setup.py (path:/tmp/pip-FdnA8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:07:02 INFO - Running setup.py (path:/tmp/pip-qmKLc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:07:02 INFO - Running setup.py (path:/tmp/pip-27v0FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:07:03 INFO - Running setup.py (path:/tmp/pip-zkTYJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:07:03 INFO - Running setup.py (path:/tmp/pip-_Chs_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:07:03 INFO - Running setup.py (path:/tmp/pip-slV2Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:07:03 INFO - Running setup.py (path:/tmp/pip-rK5P54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:07:03 INFO - Running setup.py (path:/tmp/pip-Htc4_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:07:03 INFO - Running setup.py (path:/tmp/pip-evlQZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:07:03 INFO - Running setup.py (path:/tmp/pip-oWEURl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:07:03 INFO - Running setup.py (path:/tmp/pip-dmT2fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:07:03 INFO - Running setup.py (path:/tmp/pip-4iJna4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:03 INFO - Running setup.py (path:/tmp/pip-AGCZTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:07:03 INFO - Running setup.py (path:/tmp/pip-I7Nk0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:07:03 INFO - Running setup.py (path:/tmp/pip-Kmy6VF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:07:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:07:03 INFO - Running setup.py install for manifestparser 18:07:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:07:03 INFO - Running setup.py install for mozcrash 18:07:04 INFO - Running setup.py install for mozdebug 18:07:04 INFO - Running setup.py install for mozdevice 18:07:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:07:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:07:04 INFO - Running setup.py install for mozfile 18:07:04 INFO - Running setup.py install for mozhttpd 18:07:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:07:04 INFO - Running setup.py install for mozinfo 18:07:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:07:04 INFO - Running setup.py install for mozInstall 18:07:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:07:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:07:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:07:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:07:04 INFO - Running setup.py install for mozleak 18:07:04 INFO - Running setup.py install for mozlog 18:07:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:07:04 INFO - Running setup.py install for moznetwork 18:07:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:07:05 INFO - Running setup.py install for mozprocess 18:07:05 INFO - Running setup.py install for mozprofile 18:07:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:07:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:07:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:07:05 INFO - Running setup.py install for mozrunner 18:07:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:07:05 INFO - Running setup.py install for mozscreenshot 18:07:05 INFO - Running setup.py install for moztest 18:07:05 INFO - Running setup.py install for mozversion 18:07:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:07:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:07:05 INFO - Cleaning up... 18:07:05 INFO - Return code: 0 18:07:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:05 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 0x7f72f3320f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', '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 18:07:05 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 18:07:05 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 18:07:05 INFO - Using env: {'DISPLAY': ':0', 18:07:05 INFO - 'HOME': '/home/cltbld', 18:07:05 INFO - 'LANG': 'en_US.UTF-8', 18:07:05 INFO - 'LANGUAGE': 'en_US:en', 18:07:05 INFO - 'LOGNAME': 'cltbld', 18:07:05 INFO - 'MAIL': '/var/mail/cltbld', 18:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:05 INFO - 'MOZ_NO_REMOTE': '1', 18:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:05 INFO - 'NO_EM_RESTART': '1', 18:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:05 INFO - 'PWD': '/builds/slave/test', 18:07:05 INFO - 'SHELL': '/bin/bash', 18:07:05 INFO - 'SHLVL': '1', 18:07:05 INFO - 'TERM': 'linux', 18:07:05 INFO - 'TMOUT': '86400', 18:07:05 INFO - 'USER': 'cltbld', 18:07:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:05 INFO - '_': '/tools/buildbot/bin/python'} 18:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:07:05 INFO - Running setup.py (path:/tmp/pip-KzUrvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:07:05 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)) 18:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:07:05 INFO - Running setup.py (path:/tmp/pip-4p1HHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:07:06 INFO - Running setup.py (path:/tmp/pip-LP8nB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:07:06 INFO - Running setup.py (path:/tmp/pip-9wx6OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:07:06 INFO - Running setup.py (path:/tmp/pip-foxNlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:07:06 INFO - Running setup.py (path:/tmp/pip-lMrNmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:07:06 INFO - Running setup.py (path:/tmp/pip-30lsHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:07:06 INFO - Running setup.py (path:/tmp/pip-1nagCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:07:06 INFO - Running setup.py (path:/tmp/pip-3ldZHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:07:06 INFO - Running setup.py (path:/tmp/pip-KNsfB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:07:06 INFO - Running setup.py (path:/tmp/pip-oJAanl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:07:06 INFO - Running setup.py (path:/tmp/pip-RaaoIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:07:06 INFO - Running setup.py (path:/tmp/pip-dgvhYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:07:06 INFO - Running setup.py (path:/tmp/pip-zKZYeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:06 INFO - Running setup.py (path:/tmp/pip-qcKdPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:06 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)) 18:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:07:06 INFO - Running setup.py (path:/tmp/pip-Gkn7or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:07:07 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)) 18:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:07:07 INFO - Running setup.py (path:/tmp/pip-uGgvZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:07:07 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)) 18:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:07 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)) 18:07:07 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:07:07 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:07:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:07:07 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 18:07:07 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 18:07:07 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 18:07:07 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 18:07:07 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 18:07:07 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 18:07:09 INFO - Downloading blessings-1.6.tar.gz 18:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:07:09 INFO - Installing collected packages: blessings 18:07:09 INFO - Running setup.py install for blessings 18:07:09 INFO - Successfully installed blessings 18:07:09 INFO - Cleaning up... 18:07:09 INFO - Return code: 0 18:07:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:07:09 INFO - Reading from file tmpfile_stdout 18:07:09 INFO - Current package versions: 18:07:09 INFO - argparse == 1.2.1 18:07:09 INFO - blessings == 1.6 18:07:09 INFO - blobuploader == 1.2.4 18:07:09 INFO - docopt == 0.6.1 18:07:09 INFO - functools32 == 3.2.3-2 18:07:09 INFO - jsonschema == 2.5.1 18:07:09 INFO - manifestparser == 1.1 18:07:09 INFO - mozInstall == 1.12 18:07:09 INFO - mozcrash == 0.17 18:07:09 INFO - mozdebug == 0.1 18:07:09 INFO - mozdevice == 0.48 18:07:09 INFO - mozfile == 1.2 18:07:09 INFO - mozhttpd == 0.7 18:07:09 INFO - mozinfo == 0.9 18:07:09 INFO - mozleak == 0.1 18:07:09 INFO - mozlog == 3.4 18:07:09 INFO - moznetwork == 0.27 18:07:09 INFO - mozprocess == 0.23 18:07:09 INFO - mozprofile == 0.28 18:07:09 INFO - mozrunner == 6.12 18:07:09 INFO - mozscreenshot == 0.1 18:07:09 INFO - mozsystemmonitor == 0.3 18:07:09 INFO - moztest == 0.7 18:07:09 INFO - mozversion == 1.4 18:07:09 INFO - psutil == 3.1.1 18:07:09 INFO - requests == 1.2.3 18:07:09 INFO - wsgiref == 0.1.2 18:07:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:09 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 0x7f72f3320f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', '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 18:07:09 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 18:07:09 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 18:07:09 INFO - Using env: {'DISPLAY': ':0', 18:07:09 INFO - 'HOME': '/home/cltbld', 18:07:09 INFO - 'LANG': 'en_US.UTF-8', 18:07:09 INFO - 'LANGUAGE': 'en_US:en', 18:07:09 INFO - 'LOGNAME': 'cltbld', 18:07:09 INFO - 'MAIL': '/var/mail/cltbld', 18:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:09 INFO - 'MOZ_NO_REMOTE': '1', 18:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:09 INFO - 'NO_EM_RESTART': '1', 18:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:09 INFO - 'PWD': '/builds/slave/test', 18:07:09 INFO - 'SHELL': '/bin/bash', 18:07:09 INFO - 'SHLVL': '1', 18:07:09 INFO - 'TERM': 'linux', 18:07:09 INFO - 'TMOUT': '86400', 18:07:09 INFO - 'USER': 'cltbld', 18:07:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:09 INFO - '_': '/tools/buildbot/bin/python'} 18:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:09 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)) 18:07:09 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)) 18:07:09 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)) 18:07:09 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)) 18:07:09 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)) 18:07:09 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)) 18:07:09 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)) 18:07:09 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)) 18:07:09 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)) 18:07:09 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)) 18:07:09 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)) 18:07:09 INFO - Cleaning up... 18:07:09 INFO - Return code: 0 18:07:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:09 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 0x7f72f3320f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', '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 18:07:09 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 18:07:09 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 18:07:09 INFO - Using env: {'DISPLAY': ':0', 18:07:09 INFO - 'HOME': '/home/cltbld', 18:07:09 INFO - 'LANG': 'en_US.UTF-8', 18:07:09 INFO - 'LANGUAGE': 'en_US:en', 18:07:09 INFO - 'LOGNAME': 'cltbld', 18:07:09 INFO - 'MAIL': '/var/mail/cltbld', 18:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:09 INFO - 'MOZ_NO_REMOTE': '1', 18:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:09 INFO - 'NO_EM_RESTART': '1', 18:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:09 INFO - 'PWD': '/builds/slave/test', 18:07:09 INFO - 'SHELL': '/bin/bash', 18:07:09 INFO - 'SHLVL': '1', 18:07:09 INFO - 'TERM': 'linux', 18:07:09 INFO - 'TMOUT': '86400', 18:07:09 INFO - 'USER': 'cltbld', 18:07:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:09 INFO - '_': '/tools/buildbot/bin/python'} 18:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:07:09 INFO - Cleaning up... 18:07:09 INFO - Return code: 0 18:07:09 INFO - Running post-action listener: _resource_record_post_action 18:07:09 INFO - Running post-action listener: _start_resource_monitoring 18:07:09 INFO - Starting resource monitoring. 18:07:09 INFO - [mozharness: 2016-09-21 01:07:09.950053Z] Finished create-virtualenv step (success) 18:07:09 INFO - [mozharness: 2016-09-21 01:07:09.950613Z] Running install step. 18:07:09 INFO - Running pre-action listener: _resource_record_pre_action 18:07:09 INFO - Running main action method: install 18:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:07:10 INFO - Reading from file tmpfile_stdout 18:07:10 INFO - Detecting whether we're running mozinstall >=1.0... 18:07:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:07:10 INFO - Reading from file tmpfile_stdout 18:07:10 INFO - Output received: 18:07:10 INFO - Usage: mozinstall [options] installer 18:07:10 INFO - Options: 18:07:10 INFO - -h, --help show this help message and exit 18:07:10 INFO - -d DEST, --destination=DEST 18:07:10 INFO - Directory to install application into. [default: 18:07:10 INFO - "/builds/slave/test"] 18:07:10 INFO - --app=APP Application being installed. [default: firefox] 18:07:10 INFO - mkdir: /builds/slave/test/build/application 18:07:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:07:27 INFO - Reading from file tmpfile_stdout 18:07:27 INFO - Output received: 18:07:27 INFO - /builds/slave/test/build/application/firefox/firefox 18:07:27 INFO - Running post-action listener: _resource_record_post_action 18:07:27 INFO - [mozharness: 2016-09-21 01:07:27.681283Z] Finished install step (success) 18:07:27 INFO - [mozharness: 2016-09-21 01:07:27.681528Z] Running run-tests step. 18:07:27 INFO - Running pre-action listener: _resource_record_pre_action 18:07:27 INFO - Running main action method: run_tests 18:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:07:27 INFO - Python 2.7.3 18:07:27 INFO - Return code: 0 18:07:27 INFO - grabbing minidump binary from tooltool 18:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:27 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 0x127bf60>, '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 0x127cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:07:27 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 18:07:27 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 18:07:27 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 18:07:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:07:27 INFO - Return code: 0 18:07:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:07:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:07:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:07:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:07:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:07:27 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/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 18:07:27 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/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 18:07:27 INFO - Using env: {'DISPLAY': ':0', 18:07:27 INFO - 'HOME': '/home/cltbld', 18:07:27 INFO - 'LANG': 'en_US.UTF-8', 18:07:27 INFO - 'LANGUAGE': 'en_US:en', 18:07:27 INFO - 'LOGNAME': 'cltbld', 18:07:27 INFO - 'MAIL': '/var/mail/cltbld', 18:07:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:07:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:27 INFO - 'MOZ_NO_REMOTE': '1', 18:07:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:27 INFO - 'NO_EM_RESTART': '1', 18:07:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:27 INFO - 'PWD': '/builds/slave/test', 18:07:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:07:27 INFO - 'SHELL': '/bin/bash', 18:07:27 INFO - 'SHLVL': '1', 18:07:27 INFO - 'TERM': 'linux', 18:07:27 INFO - 'TMOUT': '86400', 18:07:27 INFO - 'USER': 'cltbld', 18:07:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045', 18:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:27 INFO - '_': '/tools/buildbot/bin/python'} 18:07:27 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/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 18:07:28 INFO - mozversion application_buildid: 20160920153005 18:07:28 INFO - mozversion application_changeset: 005bf983f9e34c0e905830bddb4e54e9a1e1b7c1 18:07:28 INFO - mozversion application_display_name: Nightly 18:07:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:07:28 INFO - mozversion application_name: Firefox 18:07:28 INFO - mozversion application_remotingname: firefox 18:07:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:07:28 INFO - mozversion application_vendor: Mozilla 18:07:28 INFO - mozversion application_version: 52.0a1 18:07:28 INFO - mozversion platform_buildid: 20160920153005 18:07:28 INFO - mozversion platform_changeset: 005bf983f9e34c0e905830bddb4e54e9a1e1b7c1 18:07:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:07:28 INFO - mozversion platform_version: 52.0a1 18:07:28 INFO - using testdate: 1474420048 18:07:28 INFO - actual date: 1474420048 18:07:28 INFO - starting webserver on 'localhost:54332' 18:07:28 INFO - SUITE-START | Running 2 tests 18:07:28 INFO - TEST-START | dromaeo_css 18:07:28 INFO - operating with platform_type : linux_ 18:07:28 INFO - Initialising browser for dromaeo_css test... 18:07:28 INFO - TEST-INFO | started process 32233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqgpYk/profile http://localhost:54332/getInfo.html) 18:07:32 INFO - PROCESS | 32233 | __metrics Screen width/height:1600/1200 18:07:32 INFO - PROCESS | 32233 | colorDepth:24 18:07:32 INFO - PROCESS | 32233 | Browser inner width/height: 1024/697 18:07:32 INFO - PROCESS | 32233 | __metrics 18:07:33 INFO - PROCESS | 32233 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:07:33 INFO - PROCESS | 32233 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:07:33 INFO - PROCESS | 32233 | console.error: PushService: 18:07:33 INFO - PROCESS | 32233 | stateChangeProcessEnqueue: Error transitioning state 18:07:33 INFO - PROCESS | 32233 | UnknownError 18:07:34 INFO - TEST-INFO | 32233: exit 0 18:07:34 INFO - Browser initialized. 18:07:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:07:34 INFO - TEST-INFO | started process 32316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqgpYk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:07:46 INFO - PROCESS | 32316 | RSS: Main: 173551616 18:07:46 INFO - PROCESS | 32316 | 18:08:37 INFO - PROCESS | 32316 | 1474420117773 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] 18:10:47 INFO - PROCESS | 32316 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54332/tests/dromaeo/cssquery-ext.html) 18:10:48 INFO - PROCESS | 32316 | RSS: Main: 311242752 18:10:48 INFO - PROCESS | 32316 | 18:13:51 INFO - PROCESS | 32316 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-ext.html (next: http://localhost:54332/tests/dromaeo/cssquery-jquery.html) 18:13:51 INFO - PROCESS | 32316 | RSS: Main: 285057024 18:13:51 INFO - PROCESS | 32316 | 18:16:53 INFO - PROCESS | 32316 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54332/tests/dromaeo/cssquery-mootools.html) 18:16:54 INFO - PROCESS | 32316 | RSS: Main: 252211200 18:16:54 INFO - PROCESS | 32316 | 18:19:56 INFO - PROCESS | 32316 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54332/tests/dromaeo/cssquery-prototype.html) 18:19:57 INFO - PROCESS | 32316 | RSS: Main: 255533056 18:19:57 INFO - PROCESS | 32316 | 18:22:59 INFO - PROCESS | 32316 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54332/tests/dromaeo/cssquery-yui.html) 18:23:00 INFO - PROCESS | 32316 | RSS: Main: 215134208 18:23:00 INFO - PROCESS | 32316 | 18:26:03 INFO - PROCESS | 32316 | Cycle 1(1): loaded http://localhost:54332/tests/dromaeo/cssquery-yui.html (next: http://localhost:54332/tests/dromaeo/cssquery-dojo.html) 18:26:03 INFO - PROCESS | 32316 | RSS: Main: 301694976 18:26:03 INFO - PROCESS | 32316 | 18:26:03 INFO - PROCESS | 32316 | __start_tp_report 18:26:03 INFO - PROCESS | 32316 | _x_x_mozilla_page_load 18:26:03 INFO - PROCESS | 32316 | _x_x_mozilla_page_load_details 18:26:03 INFO - PROCESS | 32316 | |i|pagename|runs| 18:26:03 INFO - PROCESS | 32316 | |0;dojo.html;2959.9196293352925;3000.7599392048637;3002.534607135894;3025.3344264261855;3043.7564994800405;5138.075146473633;5165.535101840834;5231.110711179099;5238.214267859823;5267.841964741055;5229.79080836767;5267.28891599634;5322.627416080876;5324.148136298193;5331.147016477365;4750.762461876892;4773.904521909577;4840.491748366424;4848;4862.3922009748785;4911.386076740408;4916.754162291889;4948.802047918097;4969.875753106165;4991.875203119915;4753.429588449374;4776.259679749644;4814.229723244299;4866.489018653044;4874.975625121851;4878.634102442331;4884.975575122102;4930;4943.678660887031;4966.180580204262;4821.879453013703;4846.200376937801;4868.63485238605;4880.194767863299;4910.312556242129;5146.228065790124;5214.973925130388;5350.491703288181;5352.598555108343;5419.674819510842;5569.192467092289;5574.136008918624;5578.888422231533;5581.023320918864;5585.944140558583;5555.416681248492;5569.470900264469;5587.580931430119;5593.356763972114;5597.384287728347;5194.792208311701;5243.501867322599;5245.213218017289;5246.737663116829;5253.4221235664045;5678.886422271531;5688.573356998241;5728.1694154348215;5740.770369185186;5748.971255143698;5569.832905012856;5574.665520068809;5583.218349431083;5586.525145362609;5593.888122237532;5597.412271711411;5597.692126933058;5599.300087489064;5607.102863541895;5610.831675049755;5572.777088916398;5573.665580065209;5579.609427340048;5584;5584.804531841366;5562.833115006556;5632.436756324335;5648.322201335866;5686.57350698691;5710.229119068956;4397.6042156206095;4398.8020539075815;4442.355858400514;4445.044315472189;4450.3991961085485;3902.1415288636454;3909.3158697227873;3922.0391004203584;3928.4500169976227;3970.146418520032;5229.372475302912;5287.603429742785;5333.599980001515;5341.65279256847;5509.201165830932;5713.6857472838565;5715.771369145271;5716.942365662366;5748.540116790647;5783.8554036149435;5383.946160538423;5388.515033646991;5395;5395.325584301962;5405.675659460445;4776.880577985578;4787.114383839001;4925.236588328815;4952.232403977389;5006;5881.176635271066;5947.31605865331;5950.910736338872;6025.0359942409;6025.246844144482;5691.800786972436;5744.770209191585;5745.253117094751;5757.136429535603;5757.596968212185;5707.086866101404;5848.795292164754;5913.113033045078;5923;5925.911111333419;5548.55611551083;5633.887322253614;5641.605087643826;5653.745581448927;5696.8006119785605;5733;5762.337331206965;5766.6540007598;5772.480476757112;5773.422657734193;5355.5983301253345;5362.731863406892;5369.812056578001;5371.40914499397;5376.542993845567;5391.865203369947;5461.098918678533;5469.75386107634;5522.834314970557;5614.775408983595;5481.890362192814;5530.419305972815;5530.446955304437;5535.972320138373;5543.861403464784;5438.673679579238;5472.616916815785;5525.889482210253;5535.671438854726;5574.442555744393;5364.14173732201;5364.249005139206;5393.460653934575;5424.484673955968;5475.917861232005 18:26:03 INFO - PROCESS | 32316 | |1;ext.html;575.6804973239853;605.4520658803781;607.5018484842429;622.7695752571548;627.4478458956117;32080.197995050105;45016;45927.540724592785;45959.31061034087;45968.3104753429;46255.76872115643;46623.76688116563;46754;46765.76617116918;46798.76600617001;8915.375923685344;9075.500847453388;9076.137766912132;9080.182783549479;9083.318751093695;8955.552222388887;9058.048904864992;9063.773405664846;9069.95465022674;9070.501122438263;9020.323475739313;9083.818323633523;9084.273258139334;9090.363674542785;9094.727158185233;9031.819363612723;9054.139856713602;9080.228180604656;9086.727398178065;9092.499912504809;8900.154485323885;8984;8986.640534378617;8990.640374385017;8991.505467199302;43753.78123109396;43850;44167.77916110431;44190.558094418964;44198;3360.428727116396;3484.303139372136;3612.5123108380294;3710.703143748494;3917.4515567820526;32655.836720816245;32945.67054329474;33356.833215834005;33361.833190834135;34688.6531134688;4048.7773172475504;4070.979645101785;4092.1406504634065;4169.624733773944;4302.956970430287;366221;367351.16324418475;367603;367865;368507;55707.721461393245;60321.69839150864;60496.69751651213;60671;60732.392676073556;56230.43769562334;62447.375526245065;63865.36134638687;63985.680071599345;66897.33102669008;15237.923810380877;15361.846381536265;15378.923105384401;15381.230938453256;15400.383984640714;12481.500739970481;12623.93688031554;12638.55765048219;12640.431180596896;12649.747005059848;15872.841271587367;16380.180990950405;18200;18459;18733.625327493373;5655.208270842086;5700.572457065737;5709.628874123252;5757.67573458107;5857.4435428634215;892.1658249536704;911.1230864419317;952.7379970508027;1040.8334666453331;1060.105910863332;29851.85074074616;31817.204569885937;31891.36217275688;32750.836245819097;32764.836175818968;1046.2310202001522;1101.0090918173707;1119.322809700136;1123.859517560305;1129.9943500282611;16168.75746863798;17266.827331726523;17288.22203000868;17905.820941790676;18595;520528;734271;746766;754411;755651;60081.399186007584;60442.39557604455;60475.39524604697;60543;60621.09068363978;1287.6909541709922;1321.5903070048316;1335.8998075144402;1364.0656150536913;1365.5015919189623;30680.846595766878;32917.17707057343;32929.835350824054;33469.33061338808;34059.4891076639;53297;53519.46480535145;53651;53694.73152634212;53704.73147634237;433568;434784;437644;438132;439267;25063.122790702237;26172.476550469266;27892.58161127544;29002.854985724935;29171.708282916898;47621.52378476171;48564.51435485741;49136.5431728405;49688.75155624199;49841.25238121504;38934.80532597319;39340.2131957365;40132.1973560533;40375.798121009204;41654.583454166284;40235.89718067962;40736.18527629371;41996;42089.36865946952;42198.367024495274;39640.60359396369;40609;41531.584684152775;41546;41566.168676626905;33931.660683393835;36845.0323759579;37067.443988339655;37341.25317493689;37866.62133378631;27265.59101613517;27711;27818.860905695343;28175.71824281731;28198.85900570484 18:26:03 INFO - PROCESS | 32316 | |2;jquery.html;391.8648066417085;391.89222963684966;402.9637332640063;408.17141203357187;424.83643797138114;13505.290090588498;17892.642147157065;18013.36953206638;19586;19588.804111958878;18902;19150.712739308885;19678.606427871433;19746;20008.399748007545;5509.779608815653;5551.528120109775;5683.744231509571;5704.1443783432405;5721.856953576153;5685.459881311269;5692.57305702074;5727.770889164429;5733.140028995643;5735;5499.835004949838;5642.57680673949;5669.574781891375;5673.432656734335;5681.9431805681825;5444.156155795858;5622.943770562303;5691.630044047124;5702.087665973445;5704.828855134353;5059.3169922060415;5089.05852417304;5092.185250359962;5098.694078355311;5099.107656160157;22822;22991.31026069204;23061;23470.178543750888;23817.404564885845;2326.8836558172193;2328.0571368595747;2331.160782118436;2343.4727186383097;2363.2910126962015;14792.11247325164;14828.481003164838;14841.628959275997;15052.172130532816;15435.691286174213;1860.823221793941;1894.4411398637435;1914.7223652570437;1975.5258737902943;2001.3895761792648;82947;84000;84158.57920710418;84546.15453845444;86785;10418.895811041793;10500.159987201005;10864.891351086388;11032.558697652164;11038.779224415466;13372.866271337356;15318.234088295541;15328.310226039855;15369.231538423033;15378.3079761411;7229.819254518679;7758.806029849299;8037.959810200911;8138.9186108138165;8267.875981860278;7750.534967901831;8068.7175948841505;8074.919250807534;8080.515169089874;8203.75388738327;6601.2738598754095;6612.2726500084955;6635.900461493082;6652.174999375282;6684.398404143651;1837.5222442165134;1908.46562962368;1923.8749481283671;1950.697641865513;1997.0813425823992;852.4160949749441;951.4196340232453;988.2588058955783;996.267743208741;1006.4866917871792;18251.087445627665;19839.404817855488;20199.596008079756;20363.287284944956;20520.281790137273;993.5082134343546;1000.3047881722279;1005.0753306957616;1038.3925403638805;1051.9105876000472;10559.968327023513;11333.659990200307;11379.846356079972;11502.942485287687;11605.709857253467;500070;500613;506336;513893;519039;84211.57894210612;84356.57821710852;86223;87702.56148719216;88278;950.1068995144681;960.519740129935;994.6220436234184;999.0858364596313;1001.929864909464;17268.827311727226;17851.285948561912;18326.26694932188;18328.725069123706;18354.449366519028;40649.18701625892;41362.37956430596;41645.79177104095;42207.577924220364;42673.78663106789;54160.45839541712;54425.72787136039;55306.72346638241;56869.43130568641;58263;8020.035091402644;8393.958030210055;8461.576921154041;8595.742127736177;8600.881885354864;13199.274039927512;13224.603261902159;13299.66750831237;13300.46798128064;13339.399727012114;11347.37589432589;11482.94258528702;11605.187636865676;11614.70963225926;11825.349605771766;10700.143988481059;11056.502457389275;11186.608468703556;11236.26964247354;11846.526138954345;11942.582009629621;11971.521139154336;12047.096467765128;12176.634700958986;12220.694482638006;8165.550894700848;8319.750407487785;8403;8521.659133634834;8614.483131012159;10834.349939003685;10930.726731831768;11168.329900206014;11225.719357015812;11485.942570287096 18:26:03 INFO - PROCESS | 32316 | |3;mootools.html;1265.152347926889;1436.6623843396796;1481.2223582619124;1492.2389581313528;1577.928993195306;7890.960545197273;8607.225349718532;9007.459552426842;9009.279257659397;9243.95378023109;9085.136911993366;9165;9168.358214924958;9182.127697868691;9183;2377.2986968844148;2408.494216214597;2410.288964755401;2415.3478560788576;2430.9392265193424;2312.6993490846253;2313.4794671199015;2365.2312998275543;2374.442006128567;2374.7625237476286;2314.976850231493;2362.7400985891536;2371.8221133414977;2391.485830546432;2396.101461951768;2284.6116160252795;2300.3903965449085;2306.550222706573;2306.550222706573;2336.6495025746276;2311.8266130040315;2312.4103353644714;2315.5253173099472;2320.9651855222187;2321.721393432782;8773.824523509558;8970.102989700978;9001.324900632479;9050;9060.77348066297;4871.196252618313;5066.670666406671;5076.162433198518;5084.542391184811;5094.083065048289;3177.380410819891;3325.833708314575;3378.797272163678;3393.5588373511287;3395.303962687643;1058.9735256618646;1074.978500429995;1084.452351562456;1099.6261271167841;1106.3417266726285;12441.129120961536;12490.562830300896;12565.057620678486;12587.622371328875;12689.619311420765;4381.605655491021;4505.977470112629;4594.724316541018;4615.976920115378;4689.320048592935;10030.699079027641;10032.79934401308;10035.247356448295;10037;10037.648682296085;5151.330327057459;5161.74191290434;5165.974170129125;5167.560757335594;5183.196604526304;4144.150449157915;4266.893327666833;4658.976705116453;4783.521647835259;4838.274258861199;3704.3332200204222;3797.715171362104;3818.3508803503473;3860.092878173627;3870.4000879863665;1162.203890335123;1167.1246565076192;1171.1099564331;1176.0944073063692;1200.8799120087922;836.9497830130211;941.1341565759518;952.1668540027476;955.7180631713661;978.1245785022508;5768.884622307531;5884.205632239678;5914.201582786355;5991.5206783457215;6094.847628809227;466.91128685549637;489.3149590573155;489.42003725585295;490.49724032866595;492.05525391248887;4074.4295798588223;4157.667386609124;4174.3321068628875;4201.516825565038;4203.789810509462;10889;11076.778464430667;11136.944315278533;11138.777224455465;11148.777024459465;10880.564777408816;10946;11016.449177541252;11025.558977640805;11034.889651103547;7894.64474098667;8124.187581241947;8162.14297498766;8185.263326300543;8307.875381869277;5956.3282253487605;6006.849828754316;6123.877522449437;6153.27708241693;6173.876522469615;10192.949035254776;10235.488225588542;10294.639687610897;10335.483225838829;10423.166146708094;10327.690169294932;10469.267151299337;10470.633527826489;10539.841902371318;10681.305715128492;7290.198078211499;7464.066991626047;7466;8028.357731381592;8132;8239.258466738022;8319.542425166674;8436.662533498591;8733.301335892986;8984.146506081912;7857.253560911704;7986.920130798618;8022.398320125897;8113.310368618733;8293.129221431664;7734.149243583314;7858.371330293677;7905.407094467823;7945.960270198612;8007.639656215368;6977.441804655514;7040.0847889774;7042.260562640849;7080.504364694422;7090.64546772649;5200.245964335226;5279.47205279469;5303.416624171261;5306.071437498499;5336.653117547347;5198.726312053571;5232.3982741985155;5237.973810130925;5276.947230527646;5306.097963346163 18:26:03 INFO - PROCESS | 32316 | |4;prototype.html;322.79986408426777;334.2829630442699;336.8635702540471;338.7577881814502;344.66739596289574;5057.544820966113;5128.9230661540105;5199.4800519947985;5227.973860130699;5238.835126074775;5057.90097109699;5095.261187127873;5167.715775632339;5167.896642067157;5185;4127.380892866079;4128.256913755523;4134.52452967908;4145.419641250227;4149.771762553059;3987.4616926714957;4101.79491025449;4127.360259159835;4146.709730318879;4156.939980305018;4102.256540970076;4117.711760176789;4119.423280740699;4119.897002574945;4153.460050193486;4109.2808758467145;4109.6712263019035;4123.257813593552;4135.234981528427;4161.895952601179;3681.263747250534;3682.852685892588;3684.7604905681046;3694.8152592370275;3703.2593481303848;4987.202047672355;5075.213341932006;5094.337736094284;5104.948950510485;5106.208537676666;4640.09518143962;4670.743109128996;4672.976635116803;4685.88285292867;4703.764811759433;5386.596005299618;5392.4337944515655;5398.91901621476;5406.459354064601;5409.810656626999;3814.1608846053823;3947.4276229946495;3948.368261078214;3957.6438120569;3962.801859907022;5561.332640083176;5595.832125036255;5603.383627800898;5620.213170156181;5628.493435590816;4058.5738497457933;4079.714419990572;4082.2447847148374;4083.571225021389;4096.774677392712;4034.8789536313957;4107.281225785476;4127.380892866094;4144.212599606065;4144.3990621359735;4622.884427889262;4648.2562789953445;4651.488336283006;4659.370984917061;4695.366125573072;5420.159875219348;5434.972825135928;5435.211894275387;5437.6346289364255;5450.482204190595;1312.7224265898658;1342.234926092118;1374.6700791809894;1376.6214291069837;1424.3732757586629;904.2359206470522;949.9810003800023;954.4893481987103;956.9952150239204;962.5331714118647;4687.671862969628;4695.366125573004;4695.577398034194;4696.459907110658;4709.246520556694;4847.61842874779;4879.707217566957;4904.926426103611;4907.705537667752;4914.419929537022;4589.954100458953;4648.233041548175;4681.765911704401;4682.578567928903;4725;2724.768394686474;2957.260684828793;2960.1267626050367;2965.1845742420574;2967.2433529449854;5723.5707321950185;5762.30852297727;5776.277965254343;5809.24479817621;5818.330891947396;5484.957858006966;5625.521830644441;5670.489655930986;5717.284814555616;5745.885082298414;5787;5802.82591522255;5807.245058142415;5814.883702326015;5819.6508209507565;5609.186667933045;5624.521915637217;5634.859128521656;5646.71766411686;5650.745716442852;5282.468084255523;5546.916796248141;5559.971405290034;5595.496405323541;5601.439856014366;5821.505172060422;5821.970890145522;5840.912386314294;5841.94158058431;5881.73532191061;3877.340852055214;4046.43349931004;4058.5738497458524;4064.8577299794365;4071.9389209162478;5349.759260833194;5586.40787375596;5590.720463976866;5595.804146854841;5628.268325117709;5218.173639226392;5363.551841002985;5430.755615997211;5464.885015541262;5467;5446.21029950647;5447.972760136174;5454.754536045808;5456.836294911159;5468.371137319259;5280.20796880471;5408.405075441619;5420.539254163283;5426.620136590401;5447.53695935834;5459.590530710133;5484.8354549363585;5492.533134683436;5498.725063746877;5500.779968801203;5380.461953804588;5392.1372580388515;5403.378611459575;5404.32445944257;5425 18:26:03 INFO - PROCESS | 32316 | |5;yui.html;699.8075529229465;744.9478536502444;785.6739453126953;788.2472239011744;826.4545400035976;12997.285149316784;14079.240094988127;14088.36602352894;14088.71822563548;14090.154590724564;12414;12443.875561244386;12447.253164810118;12461.563845265418;12468.064895132857;654.254150268694;666.7499687617144;773.4817672159638;781.4998401023336;785.9410544209208;791.5290402210676;791.6872835230081;793.2662287384176;793.274154148953;793.3653077537975;847.6185716427601;847.7499137754377;848.6944699908029;848.7453763870814;849.3417601358934;692.4529621598956;706.6784613001098;829.5644786487082;846.2595229174473;848.4315508609246;613.2548953022055;616.1312549305458;617.1606615003592;617.305531277313;617.5245061302817;12938.417771200318;12951.740965180737;12966.740665186644;12980.545680901218;12981.610551683465;13403.329833508285;13472.5284615038;13814.516491922734;13817.170969741746;14254.786178207336;12529.812052819216;12580.104701630227;12585.433655485525;12979.675508112372;13046.608601741867;4462.3752674625575;4503.347014682885;4513.571210734975;4514.210013247669;4548.772561371951;80890.9053823462;83120.58439707823;83277;84691.57654211689;85514;10177.389356638625;10593.152547796159;11547.133964952494;11630.88369116298;11840.33592441711;17365.479035628952;18551.44345669632;18703.625927481375;18745.343912963253;18754.1560629772;7321.341079302888;7672.5012874163;7741.651625676858;7749.883751743729;7806.0632724073475;4252.978735106305;4261.850835220815;4325.891852703708;4453.888652783707;4474.32885067236;3272.1655977726004;3399.048266485388;3412.283420481677;3465.1163953191776;3593.2993066352333;614.6527212125135;643.8486955565438;645.4997377032837;646.7219095788856;647.5952529668957;614.8032629558498;639.9792331231678;718.4749278051869;726.894600282956;737.3363972424753;8770.3422243332;9275.675351362805;9325.300602454843;9525.57134928916;9644.614215431304;626.6334194496179;627.7018416252243;648.9772857950044;657.2671471309551;662.9436497897733;4223.704340696183;4311.353297005474;4346.348047792793;4359.869203923888;4576.130535198302;78580;92781.5360923191;128600.35699821441;129860.35069824591;132872;86175;86814;86974;103470;108507.45746271218;59473.70263148743;64572;86588.13411865926;87889.56055219682;90398;9340.078338703386;10089.545970431202;10099.545520451744;10110.443925584164;10115.342502737298;51705.7414712924;51990.48009520008;52326.73836630792;52330.47669523409;53672;70256.64871675608;78191;78668;80366;81685.18314816775;12747.553835615709;13117.437189690952;13214.471421143047;13262.734745305233;14321.355539000562;15238.542843714706;15390.923045384701;16210.918945405198;16371.181440927669;16825.91587042106;11947.522099115939;12070.818937716116;12526.37368131608;12560.43478043472;12843.357832108544;14041.438342466186;14698.926505367404;15133.167675777939;15190.088594683912;15285.465008724641;11942.70143246391;12269.93865030669;12534.56129035516;13249.735005300034;13266;10330.380177189392;10487.161027117965;10543.20925930543;11305.943470282597;11527.250728702607;10258.846117308098;11162.776744464903;11265.576246596616;11357.318560886373;11454.942725286654 18:26:03 INFO - PROCESS | 32316 | __end_tp_report 18:26:03 INFO - PROCESS | 32316 | __start_cc_report 18:26:03 INFO - PROCESS | 32316 | _x_x_mozilla_cycle_collect,1014 18:26:03 INFO - PROCESS | 32316 | __end_cc_report 18:26:03 INFO - PROCESS | 32316 | __startTimestamp1474421163440__endTimestamp 18:26:03 INFO - PROCESS | 32316 | 18:26:03 INFO - PROCESS | 32316 | ------- Summary: start ------- 18:26:03 INFO - PROCESS | 32316 | Number of tests: 6 18:26:03 INFO - PROCESS | 32316 | 18:26:03 INFO - PROCESS | 32316 | [#0] dojo.html Cycles:165 Average:5262.77 Median:5419.67 stddev:588.62 (10.9%) stddev-sans-first:562.02 18:26:03 INFO - PROCESS | 32316 | Values: 2959.9 3000.8 3002.5 3025.3 3043.8 5138.1 5165.5 5231.1 5238.2 5267.8 5229.8 5267.3 5322.6 5324.1 5331.1 4750.8 4773.9 4840.5 4848.0 4862.4 4911.4 4916.8 4948.8 4969.9 4991.9 4753.4 4776.3 4814.2 4866.5 4875.0 4878.6 4885.0 4930.0 4943.7 4966.2 4821.9 4846.2 4868.6 4880.2 4910.3 5146.2 5215.0 5350.5 5352.6 5419.7 5569.2 5574.1 5578.9 5581.0 5585.9 5555.4 5569.5 5587.6 5593.4 5597.4 5194.8 5243.5 5245.2 5246.7 5253.4 5678.9 5688.6 5728.2 5740.8 5749.0 5569.8 5574.7 5583.2 5586.5 5593.9 5597.4 5597.7 5599.3 5607.1 5610.8 5572.8 5573.7 5579.6 5584.0 5584.8 5562.8 5632.4 5648.3 5686.6 5710.2 4397.6 4398.8 4442.4 4445.0 4450.4 3902.1 3909.3 3922.0 3928.5 3970.1 5229.4 5287.6 5333.6 5341.7 5509.2 5713.7 5715.8 5716.9 5748.5 5783.9 5383.9 5388.5 5395.0 5395.3 5405.7 4776.9 4787.1 4925.2 4952.2 5006.0 5881.2 5947.3 5950.9 6025.0 6025.2 5691.8 5744.8 5745.3 5757.1 5757.6 5707.1 5848.8 5913.1 5923.0 5925.9 5548.6 5633.9 5641.6 5653.7 5696.8 5733.0 5762.3 5766.7 5772.5 5773.4 5355.6 5362.7 5369.8 5371.4 5376.5 5391.9 5461.1 5469.8 5522.8 5614.8 5481.9 5530.4 5530.4 5536.0 5543.9 5438.7 5472.6 5525.9 5535.7 5574.4 5364.1 5364.2 5393.5 5424.5 5475.9 18:26:03 INFO - PROCESS | 32316 | 18:26:03 INFO - PROCESS | 32316 | [#1] ext.html Cycles:180 Average:65653.32 Median:42143.87 stddev:140544.33 (333.5%) stddev-sans-first:140853.66 18:26:03 INFO - PROCESS | 32316 | Values: 575.7 605.5 607.5 622.8 627.4 32080.2 45016.0 45927.5 45959.3 45968.3 46255.8 46623.8 46754.0 46765.8 46798.8 8915.4 9075.5 9076.1 9080.2 9083.3 8955.6 9058.0 9063.8 9070.0 9070.5 9020.3 9083.8 9084.3 9090.4 9094.7 9031.8 9054.1 9080.2 9086.7 9092.5 8900.2 8984.0 8986.6 8990.6 8991.5 43753.8 43850.0 44167.8 44190.6 44198.0 3360.4 3484.3 3612.5 3710.7 3917.5 32655.8 32945.7 33356.8 33361.8 34688.7 4048.8 4071.0 4092.1 4169.6 4303.0 366221.0 367351.2 367603.0 367865.0 368507.0 55707.7 60321.7 60496.7 60671.0 60732.4 56230.4 62447.4 63865.4 63985.7 66897.3 15237.9 15361.8 15378.9 15381.2 15400.4 12481.5 12623.9 12638.6 12640.4 12649.7 15872.8 16380.2 18200.0 18459.0 18733.6 5655.2 5700.6 5709.6 5757.7 5857.4 892.2 911.1 952.7 1040.8 1060.1 29851.9 31817.2 31891.4 32750.8 32764.8 1046.2 1101.0 1119.3 1123.9 1130.0 16168.8 17266.8 17288.2 17905.8 18595.0 520528.0 734271.0 746766.0 754411.0 755651.0 60081.4 60442.4 60475.4 60543.0 60621.1 1287.7 1321.6 1335.9 1364.1 1365.5 30680.8 32917.2 32929.8 33469.3 34059.5 53297.0 53519.5 53651.0 53694.7 53704.7 433568.0 434784.0 437644.0 438132.0 439267.0 25063.1 26172.5 27892.6 29002.9 29171.7 47621.5 48564.5 49136.5 49688.8 49841.3 38934.8 39340.2 40132.2 40375.8 41654.6 40235.9 40736.2 41996.0 42089.4 42198.4 39640.6 40609.0 41531.6 41546.0 41566.2 33931.7 36845.0 37067.4 37341.3 37866.6 27265.6 27711.0 27818.9 28175.7 28198.9 18:26:03 INFO - PROCESS | 32316 | 18:26:03 INFO - PROCESS | 32316 | [#2] jquery.html Cycles:180 Average:29509.23 Median:12104.63 stddev:83569.28 (690.4%) stddev-sans-first:83775.11 18:26:03 INFO - PROCESS | 32316 | Values: 391.9 391.9 403.0 408.2 424.8 13505.3 17892.6 18013.4 19586.0 19588.8 18902.0 19150.7 19678.6 19746.0 20008.4 5509.8 5551.5 5683.7 5704.1 5721.9 5685.5 5692.6 5727.8 5733.1 5735.0 5499.8 5642.6 5669.6 5673.4 5681.9 5444.2 5622.9 5691.6 5702.1 5704.8 5059.3 5089.1 5092.2 5098.7 5099.1 22822.0 22991.3 23061.0 23470.2 23817.4 2326.9 2328.1 2331.2 2343.5 2363.3 14792.1 14828.5 14841.6 15052.2 15435.7 1860.8 1894.4 1914.7 1975.5 2001.4 82947.0 84000.0 84158.6 84546.2 86785.0 10418.9 10500.2 10864.9 11032.6 11038.8 13372.9 15318.2 15328.3 15369.2 15378.3 7229.8 7758.8 8038.0 8138.9 8267.9 7750.5 8068.7 8074.9 8080.5 8203.8 6601.3 6612.3 6635.9 6652.2 6684.4 1837.5 1908.5 1923.9 1950.7 1997.1 852.4 951.4 988.3 996.3 1006.5 18251.1 19839.4 20199.6 20363.3 20520.3 993.5 1000.3 1005.1 1038.4 1051.9 10560.0 11333.7 11379.8 11502.9 11605.7 500070.0 500613.0 506336.0 513893.0 519039.0 84211.6 84356.6 86223.0 87702.6 88278.0 950.1 960.5 994.6 999.1 1001.9 17268.8 17851.3 18326.3 18328.7 18354.4 40649.2 41362.4 41645.8 42207.6 42673.8 54160.5 54425.7 55306.7 56869.4 58263.0 8020.0 8394.0 8461.6 8595.7 8600.9 13199.3 13224.6 13299.7 13300.5 13339.4 11347.4 11482.9 11605.2 11614.7 11825.3 10700.1 11056.5 11186.6 11236.3 11846.5 11942.6 11971.5 12047.1 12176.6 12220.7 8165.6 8319.8 8403.0 8521.7 8614.5 10834.3 10930.7 11168.3 11225.7 11485.9 18:26:03 INFO - PROCESS | 32316 | 18:26:03 INFO - PROCESS | 32316 | [#3] mootools.html Cycles:180 Average:5824.99 Median:4637.48 stddev:3385.11 (73.0%) stddev-sans-first:3377.26 18:26:03 INFO - PROCESS | 32316 | Values: 1265.2 1436.7 1481.2 1492.2 1577.9 7891.0 8607.2 9007.5 9009.3 9244.0 9085.1 9165.0 9168.4 9182.1 9183.0 2377.3 2408.5 2410.3 2415.3 2430.9 2312.7 2313.5 2365.2 2374.4 2374.8 2315.0 2362.7 2371.8 2391.5 2396.1 2284.6 2300.4 2306.6 2306.6 2336.6 2311.8 2312.4 2315.5 2321.0 2321.7 8773.8 8970.1 9001.3 9050.0 9060.8 4871.2 5066.7 5076.2 5084.5 5094.1 3177.4 3325.8 3378.8 3393.6 3395.3 1059.0 1075.0 1084.5 1099.6 1106.3 12441.1 12490.6 12565.1 12587.6 12689.6 4381.6 4506.0 4594.7 4616.0 4689.3 10030.7 10032.8 10035.2 10037.0 10037.6 5151.3 5161.7 5166.0 5167.6 5183.2 4144.2 4266.9 4659.0 4783.5 4838.3 3704.3 3797.7 3818.4 3860.1 3870.4 1162.2 1167.1 1171.1 1176.1 1200.9 836.9 941.1 952.2 955.7 978.1 5768.9 5884.2 5914.2 5991.5 6094.8 466.9 489.3 489.4 490.5 492.1 4074.4 4157.7 4174.3 4201.5 4203.8 10889.0 11076.8 11136.9 11138.8 11148.8 10880.6 10946.0 11016.4 11025.6 11034.9 7894.6 8124.2 8162.1 8185.3 8307.9 5956.3 6006.8 6123.9 6153.3 6173.9 10192.9 10235.5 10294.6 10335.5 10423.2 10327.7 10469.3 10470.6 10539.8 10681.3 7290.2 7464.1 7466.0 8028.4 8132.0 8239.3 8319.5 8436.7 8733.3 8984.1 7857.3 7986.9 8022.4 8113.3 8293.1 7734.1 7858.4 7905.4 7946.0 8007.6 6977.4 7040.1 7042.3 7080.5 7090.6 5200.2 5279.5 5303.4 5306.1 5336.7 5198.7 5232.4 5238.0 5276.9 5306.1 18:26:03 INFO - PROCESS | 32316 | 18:26:03 INFO - PROCESS | 32316 | [#4] prototype.html Cycles:180 Average:4560.77 Median:5100.11 stddev:1325.52 (26.0%) stddev-sans-first:1290.51 18:26:03 INFO - PROCESS | 32316 | Values: 322.8 334.3 336.9 338.8 344.7 5057.5 5128.9 5199.5 5228.0 5238.8 5057.9 5095.3 5167.7 5167.9 5185.0 4127.4 4128.3 4134.5 4145.4 4149.8 3987.5 4101.8 4127.4 4146.7 4156.9 4102.3 4117.7 4119.4 4119.9 4153.5 4109.3 4109.7 4123.3 4135.2 4161.9 3681.3 3682.9 3684.8 3694.8 3703.3 4987.2 5075.2 5094.3 5104.9 5106.2 4640.1 4670.7 4673.0 4685.9 4703.8 5386.6 5392.4 5398.9 5406.5 5409.8 3814.2 3947.4 3948.4 3957.6 3962.8 5561.3 5595.8 5603.4 5620.2 5628.5 4058.6 4079.7 4082.2 4083.6 4096.8 4034.9 4107.3 4127.4 4144.2 4144.4 4622.9 4648.3 4651.5 4659.4 4695.4 5420.2 5435.0 5435.2 5437.6 5450.5 1312.7 1342.2 1374.7 1376.6 1424.4 904.2 950.0 954.5 957.0 962.5 4687.7 4695.4 4695.6 4696.5 4709.2 4847.6 4879.7 4904.9 4907.7 4914.4 4590.0 4648.2 4681.8 4682.6 4725.0 2724.8 2957.3 2960.1 2965.2 2967.2 5723.6 5762.3 5776.3 5809.2 5818.3 5485.0 5625.5 5670.5 5717.3 5745.9 5787.0 5802.8 5807.2 5814.9 5819.7 5609.2 5624.5 5634.9 5646.7 5650.7 5282.5 5546.9 5560.0 5595.5 5601.4 5821.5 5822.0 5840.9 5841.9 5881.7 3877.3 4046.4 4058.6 4064.9 4071.9 5349.8 5586.4 5590.7 5595.8 5628.3 5218.2 5363.6 5430.8 5464.9 5467.0 5446.2 5448.0 5454.8 5456.8 5468.4 5280.2 5408.4 5420.5 5426.6 5447.5 5459.6 5484.8 5492.5 5498.7 5500.8 5380.5 5392.1 5403.4 5404.3 5425.0 18:26:03 INFO - PROCESS | 32316 | 18:26:03 INFO - PROCESS | 32316 | [#5] yui.html Cycles:180 Average:20419.02 Median:4406.88 stddev:29914.87 (678.8%) stddev-sans-first:29962.14 18:26:03 INFO - PROCESS | 32316 | Values: 699.8 744.9 785.7 788.2 826.5 12997.3 14079.2 14088.4 14088.7 14090.2 12414.0 12443.9 12447.3 12461.6 12468.1 654.3 666.7 773.5 781.5 785.9 791.5 791.7 793.3 793.3 793.4 847.6 847.7 848.7 848.7 849.3 692.5 706.7 829.6 846.3 848.4 613.3 616.1 617.2 617.3 617.5 12938.4 12951.7 12966.7 12980.5 12981.6 13403.3 13472.5 13814.5 13817.2 14254.8 12529.8 12580.1 12585.4 12979.7 13046.6 4462.4 4503.3 4513.6 4514.2 4548.8 80890.9 83120.6 83277.0 84691.6 85514.0 10177.4 10593.2 11547.1 11630.9 11840.3 17365.5 18551.4 18703.6 18745.3 18754.2 7321.3 7672.5 7741.7 7749.9 7806.1 4253.0 4261.9 4325.9 4453.9 4474.3 3272.2 3399.0 3412.3 3465.1 3593.3 614.7 643.8 645.5 646.7 647.6 614.8 640.0 718.5 726.9 737.3 8770.3 9275.7 9325.3 9525.6 9644.6 626.6 627.7 649.0 657.3 662.9 4223.7 4311.4 4346.3 4359.9 4576.1 78580.0 92781.5 128600.4 129860.4 132872.0 86175.0 86814.0 86974.0 103470.0 108507.5 59473.7 64572.0 86588.1 87889.6 90398.0 9340.1 10089.5 10099.5 10110.4 10115.3 51705.7 51990.5 52326.7 52330.5 53672.0 70256.6 78191.0 78668.0 80366.0 81685.2 12747.6 13117.4 13214.5 13262.7 14321.4 15238.5 15390.9 16210.9 16371.2 16825.9 11947.5 12070.8 12526.4 12560.4 12843.4 14041.4 14698.9 15133.2 15190.1 15285.5 11942.7 12269.9 12534.6 13249.7 13266.0 10330.4 10487.2 10543.2 11305.9 11527.3 10258.8 11162.8 11265.6 11357.3 11454.9 18:26:03 INFO - PROCESS | 32316 | -------- Summary: end -------- 18:26:03 INFO - PROCESS | 32316 | 18:26:04 INFO - TEST-INFO | 32316: exit 0 18:26:04 INFO - TEST-OK | dromaeo_css | took 1116390ms 18:26:04 INFO - TEST-START | kraken 18:26:04 INFO - operating with platform_type : linux_ 18:26:04 INFO - Initialising browser for kraken test... 18:26:04 INFO - TEST-INFO | started process 32625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GNXKD/profile http://localhost:54332/getInfo.html) 18:26:08 INFO - PROCESS | 32625 | __metrics Screen width/height:1600/1200 18:26:08 INFO - PROCESS | 32625 | colorDepth:24 18:26:08 INFO - PROCESS | 32625 | Browser inner width/height: 1024/697 18:26:08 INFO - PROCESS | 32625 | __metrics 18:26:09 INFO - PROCESS | 32625 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:26:09 INFO - PROCESS | 32625 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:26:10 INFO - PROCESS | 32625 | console.error: PushService: 18:26:10 INFO - PROCESS | 32625 | stateChangeProcessEnqueue: Error transitioning state 18:26:10 INFO - PROCESS | 32625 | UnknownError 18:26:10 INFO - TEST-INFO | 32625: exit 0 18:26:10 INFO - Browser initialized. 18:26:10 INFO - Running cycle 1/1 for kraken test... 18:26:10 INFO - TEST-INFO | started process 32706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GNXKD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:22 INFO - PROCESS | 32706 | RSS: Main: 173555712 18:26:22 INFO - PROCESS | 32706 | 18:26:25 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-beat-detection) 18:26:26 INFO - PROCESS | 32706 | RSS: Main: 232275968 18:26:26 INFO - PROCESS | 32706 | 18:26:28 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-dft) 18:26:29 INFO - PROCESS | 32706 | RSS: Main: 216424448 18:26:29 INFO - PROCESS | 32706 | 18:26:32 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-fft) 18:26:33 INFO - PROCESS | 32706 | RSS: Main: 298827776 18:26:33 INFO - PROCESS | 32706 | 18:26:35 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54332/tests/kraken/driver.html?testName=audio-oscillator) 18:26:35 INFO - PROCESS | 32706 | RSS: Main: 208044032 18:26:35 INFO - PROCESS | 32706 | 18:26:38 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54332/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:26:38 INFO - PROCESS | 32706 | RSS: Main: 212197376 18:26:38 INFO - PROCESS | 32706 | 18:26:41 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54332/tests/kraken/driver.html?testName=imaging-darkroom) 18:26:42 INFO - PROCESS | 32706 | RSS: Main: 249659392 18:26:42 INFO - PROCESS | 32706 | 18:26:45 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54332/tests/kraken/driver.html?testName=imaging-desaturate) 18:26:46 INFO - PROCESS | 32706 | RSS: Main: 248381440 18:26:46 INFO - PROCESS | 32706 | 18:26:48 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54332/tests/kraken/driver.html?testName=json-parse-financial) 18:26:49 INFO - PROCESS | 32706 | RSS: Main: 248520704 18:26:49 INFO - PROCESS | 32706 | 18:26:51 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54332/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:26:51 INFO - PROCESS | 32706 | RSS: Main: 210321408 18:26:51 INFO - PROCESS | 32706 | 18:26:53 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:26:54 INFO - PROCESS | 32706 | RSS: Main: 217530368 18:26:54 INFO - PROCESS | 32706 | 18:26:56 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:26:56 INFO - PROCESS | 32706 | RSS: Main: 222076928 18:26:56 INFO - PROCESS | 32706 | 18:26:59 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:26:59 INFO - PROCESS | 32706 | RSS: Main: 223338496 18:26:59 INFO - PROCESS | 32706 | 18:27:02 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:27:03 INFO - PROCESS | 32706 | RSS: Main: 221614080 18:27:03 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | Cycle 1(1): loaded http://localhost:54332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54332/tests/kraken/driver.html?testName=ai-astar) 18:27:05 INFO - PROCESS | 32706 | RSS: Main: 272498688 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | __start_tp_report 18:27:05 INFO - PROCESS | 32706 | _x_x_mozilla_page_load 18:27:05 INFO - PROCESS | 32706 | _x_x_mozilla_page_load_details 18:27:05 INFO - PROCESS | 32706 | |i|pagename|runs| 18:27:05 INFO - PROCESS | 32706 | |0;ai-astar;109;115;113;113;112;112;113;112;111;113 18:27:05 INFO - PROCESS | 32706 | |1;audio-beat-detection;144;118;118;155;121;122;118;117;146;119 18:27:05 INFO - PROCESS | 32706 | |2;audio-dft;160;161;163;162;162;161;160;164;162;161 18:27:05 INFO - PROCESS | 32706 | |3;audio-fft;75;75;75;114;77;76;76;76;112;76 18:27:05 INFO - PROCESS | 32706 | |4;audio-oscillator;83;83;118;83;83;83;105;83;82;114 18:27:05 INFO - PROCESS | 32706 | |5;imaging-gaussian-blur;117;116;117;117;116;116;117;117;117;117 18:27:05 INFO - PROCESS | 32706 | |6;imaging-darkroom;146;146;146;146;146;148;146;147;146;146 18:27:05 INFO - PROCESS | 32706 | |7;imaging-desaturate;95;95;96;95;94;96;96;95;95;94 18:27:05 INFO - PROCESS | 32706 | |8;json-parse-financial;55;60;52;51;53;53;53;53;59;54 18:27:05 INFO - PROCESS | 32706 | |9;json-stringify-tinderbox;61;62;61;61;62;60;61;67;61;61 18:27:05 INFO - PROCESS | 32706 | |10;stanford-crypto-aes;83;86;78;82;79;79;87;79;79;79 18:27:05 INFO - PROCESS | 32706 | |11;stanford-crypto-ccm;135;126;134;124;134;125;129;130;173;126 18:27:05 INFO - PROCESS | 32706 | |12;stanford-crypto-pbkdf2;167;167;167;163;164;169;167;164;169;164 18:27:05 INFO - PROCESS | 32706 | |13;stanford-crypto-sha256-iterative;65;66;66;73;64;66;64;66;68;66 18:27:05 INFO - PROCESS | 32706 | __end_tp_report 18:27:05 INFO - PROCESS | 32706 | __start_cc_report 18:27:05 INFO - PROCESS | 32706 | _x_x_mozilla_cycle_collect,1661 18:27:05 INFO - PROCESS | 32706 | __end_cc_report 18:27:05 INFO - PROCESS | 32706 | __startTimestamp1474421225278__endTimestamp 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | ------- Summary: start ------- 18:27:05 INFO - PROCESS | 32706 | Number of tests: 14 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.57 (1.4%) stddev-sans-first:1.12 18:27:05 INFO - PROCESS | 32706 | Values: 109.0 115.0 113.0 113.0 112.0 112.0 113.0 112.0 111.0 113.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:121.50 stddev:14.51 (11.9%) stddev-sans-first:14.16 18:27:05 INFO - PROCESS | 32706 | Values: 144.0 118.0 118.0 155.0 121.0 122.0 118.0 117.0 146.0 119.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 18:27:05 INFO - PROCESS | 32706 | Values: 160.0 161.0 163.0 162.0 162.0 161.0 160.0 164.0 162.0 161.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:15.73 (20.7%) stddev-sans-first:16.40 18:27:05 INFO - PROCESS | 32706 | Values: 75.0 75.0 75.0 114.0 77.0 76.0 76.0 76.0 112.0 76.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.00 stddev:14.58 (17.6%) stddev-sans-first:15.12 18:27:05 INFO - PROCESS | 32706 | Values: 83.0 83.0 118.0 83.0 83.0 83.0 105.0 83.0 82.0 114.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:27:05 INFO - PROCESS | 32706 | Values: 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 18:27:05 INFO - PROCESS | 32706 | Values: 146.0 146.0 146.0 146.0 146.0 148.0 146.0 147.0 146.0 146.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 18:27:05 INFO - PROCESS | 32706 | Values: 95.0 95.0 96.0 95.0 94.0 96.0 96.0 95.0 95.0 94.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:2.95 (5.5%) stddev-sans-first:3.11 18:27:05 INFO - PROCESS | 32706 | Values: 55.0 60.0 52.0 51.0 53.0 53.0 53.0 53.0 59.0 54.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.00 stddev:1.95 (3.2%) stddev-sans-first:2.05 18:27:05 INFO - PROCESS | 32706 | Values: 61.0 62.0 61.0 61.0 62.0 60.0 61.0 67.0 61.0 61.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.50 stddev:3.25 (4.0%) stddev-sans-first:3.37 18:27:05 INFO - PROCESS | 32706 | Values: 83.0 86.0 78.0 82.0 79.0 79.0 87.0 79.0 79.0 79.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:132.00 stddev:14.42 (10.9%) stddev-sans-first:15.28 18:27:05 INFO - PROCESS | 32706 | Values: 135.0 126.0 134.0 124.0 134.0 125.0 129.0 130.0 173.0 126.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:167.00 stddev:2.18 (1.3%) stddev-sans-first:2.29 18:27:05 INFO - PROCESS | 32706 | Values: 167.0 167.0 167.0 163.0 164.0 169.0 167.0 164.0 169.0 164.0 18:27:05 INFO - PROCESS | 32706 | 18:27:05 INFO - PROCESS | 32706 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:2.59 (3.9%) stddev-sans-first:2.70 18:27:05 INFO - PROCESS | 32706 | Values: 65.0 66.0 66.0 73.0 64.0 66.0 64.0 66.0 68.0 66.0 18:27:05 INFO - PROCESS | 32706 | -------- Summary: end -------- 18:27:05 INFO - PROCESS | 32706 | 18:27:06 INFO - TEST-INFO | 32706: exit 0 18:27:06 INFO - TEST-OK | kraken | took 62151ms 18:27:06 INFO - SUITE-END | took 1178s 18:27:06 INFO - Completed test suite (00:19:38) 18:27:06 INFO - javascript benchmark 18:27:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2959.9196293352925, 3000.7599392048637, 3002.534607135894, 3025.3344264261855, 3043.7564994800405, 5138.075146473633, 5165.535101840834, 5231.110711179099, 5238.214267859823, 5267.841964741055, 5229.79080836767, 5267.28891599634, 5322.627416080876, 5324.148136298193, 5331.147016477365, 4750.762461876892, 4773.904521909577, 4840.491748366424, 4848.0, 4862.3922009748785, 4911.386076740408, 4916.754162291889, 4948.802047918097, 4969.875753106165, 4991.875203119915, 4753.429588449374, 4776.259679749644, 4814.229723244299, 4866.489018653044, 4874.975625121851, 4878.634102442331, 4884.975575122102, 4930.0, 4943.678660887031, 4966.180580204262, 4821.879453013703, 4846.200376937801, 4868.63485238605, 4880.194767863299, 4910.312556242129, 5146.228065790124, 5214.973925130388, 5350.491703288181, 5352.598555108343, 5419.674819510842, 5569.192467092289, 5574.136008918624, 5578.888422231533, 5581.023320918864, 5585.944140558583, 5555.416681248492, 5569.470900264469, 5587.580931430119, 5593.356763972114, 5597.384287728347, 5194.792208311701, 5243.501867322599, 5245.213218017289, 5246.737663116829, 5253.4221235664045, 5678.886422271531, 5688.573356998241, 5728.1694154348215, 5740.770369185186, 5748.971255143698, 5569.832905012856, 5574.665520068809, 5583.218349431083, 5586.525145362609, 5593.888122237532, 5597.412271711411, 5597.692126933058, 5599.300087489064, 5607.102863541895, 5610.831675049755, 5572.777088916398, 5573.665580065209, 5579.609427340048, 5584.0, 5584.804531841366, 5562.833115006556, 5632.436756324335, 5648.322201335866, 5686.57350698691, 5710.229119068956, 4397.6042156206095, 4398.8020539075815, 4442.355858400514, 4445.044315472189, 4450.3991961085485, 3902.1415288636454, 3909.3158697227873, 3922.0391004203584, 3928.4500169976227, 3970.146418520032, 5229.372475302912, 5287.603429742785, 5333.599980001515, 5341.65279256847, 5509.201165830932, 5713.6857472838565, 5715.771369145271, 5716.942365662366, 5748.540116790647, 5783.8554036149435, 5383.946160538423, 5388.515033646991, 5395.0, 5395.325584301962, 5405.675659460445, 4776.880577985578, 4787.114383839001, 4925.236588328815, 4952.232403977389, 5006.0, 5881.176635271066, 5947.31605865331, 5950.910736338872, 6025.0359942409, 6025.246844144482, 5691.800786972436, 5744.770209191585, 5745.253117094751, 5757.136429535603, 5757.596968212185, 5707.086866101404, 5848.795292164754, 5913.113033045078, 5923.0, 5925.911111333419, 5548.55611551083, 5633.887322253614, 5641.605087643826, 5653.745581448927, 5696.8006119785605, 5733.0, 5762.337331206965, 5766.6540007598, 5772.480476757112, 5773.422657734193, 5355.5983301253345, 5362.731863406892, 5369.812056578001, 5371.40914499397, 5376.542993845567, 5391.865203369947, 5461.098918678533, 5469.75386107634, 5522.834314970557, 5614.775408983595, 5481.890362192814, 5530.419305972815, 5530.446955304437, 5535.972320138373, 5543.861403464784, 5438.673679579238, 5472.616916815785, 5525.889482210253, 5535.671438854726, 5574.442555744393, 5364.14173732201, 5364.249005139206, 5393.460653934575, 5424.484673955968, 5475.917861232005], "value": 5223.136637961602, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.6804973239853, 605.4520658803781, 607.5018484842429, 622.7695752571548, 627.4478458956117, 32080.197995050105, 45016.0, 45927.540724592785, 45959.31061034087, 45968.3104753429, 46255.76872115643, 46623.76688116563, 46754.0, 46765.76617116918, 46798.76600617001, 8915.375923685344, 9075.500847453388, 9076.137766912132, 9080.182783549479, 9083.318751093695, 8955.552222388887, 9058.048904864992, 9063.773405664846, 9069.95465022674, 9070.501122438263, 9020.323475739313, 9083.818323633523, 9084.273258139334, 9090.363674542785, 9094.727158185233, 9031.819363612723, 9054.139856713602, 9080.228180604656, 9086.727398178065, 9092.499912504809, 8900.154485323885, 8984.0, 8986.640534378617, 8990.640374385017, 8991.505467199302, 43753.78123109396, 43850.0, 44167.77916110431, 44190.558094418964, 44198.0, 3360.428727116396, 3484.303139372136, 3612.5123108380294, 3710.703143748494, 3917.4515567820526, 32655.836720816245, 32945.67054329474, 33356.833215834005, 33361.833190834135, 34688.6531134688, 4048.7773172475504, 4070.979645101785, 4092.1406504634065, 4169.624733773944, 4302.956970430287, 366221.0, 367351.16324418475, 367603.0, 367865.0, 368507.0, 55707.721461393245, 60321.69839150864, 60496.69751651213, 60671.0, 60732.392676073556, 56230.43769562334, 62447.375526245065, 63865.36134638687, 63985.680071599345, 66897.33102669008, 15237.923810380877, 15361.846381536265, 15378.923105384401, 15381.230938453256, 15400.383984640714, 12481.500739970481, 12623.93688031554, 12638.55765048219, 12640.431180596896, 12649.747005059848, 15872.841271587367, 16380.180990950405, 18200.0, 18459.0, 18733.625327493373, 5655.208270842086, 5700.572457065737, 5709.628874123252, 5757.67573458107, 5857.4435428634215, 892.1658249536704, 911.1230864419317, 952.7379970508027, 1040.8334666453331, 1060.105910863332, 29851.85074074616, 31817.204569885937, 31891.36217275688, 32750.836245819097, 32764.836175818968, 1046.2310202001522, 1101.0090918173707, 1119.322809700136, 1123.859517560305, 1129.9943500282611, 16168.75746863798, 17266.827331726523, 17288.22203000868, 17905.820941790676, 18595.0, 520528.0, 734271.0, 746766.0, 754411.0, 755651.0, 60081.399186007584, 60442.39557604455, 60475.39524604697, 60543.0, 60621.09068363978, 1287.6909541709922, 1321.5903070048316, 1335.8998075144402, 1364.0656150536913, 1365.5015919189623, 30680.846595766878, 32917.17707057343, 32929.835350824054, 33469.33061338808, 34059.4891076639, 53297.0, 53519.46480535145, 53651.0, 53694.73152634212, 53704.73147634237, 433568.0, 434784.0, 437644.0, 438132.0, 439267.0, 25063.122790702237, 26172.476550469266, 27892.58161127544, 29002.854985724935, 29171.708282916898, 47621.52378476171, 48564.51435485741, 49136.5431728405, 49688.75155624199, 49841.25238121504, 38934.80532597319, 39340.2131957365, 40132.1973560533, 40375.798121009204, 41654.583454166284, 40235.89718067962, 40736.18527629371, 41996.0, 42089.36865946952, 42198.367024495274, 39640.60359396369, 40609.0, 41531.584684152775, 41546.0, 41566.168676626905, 33931.660683393835, 36845.0323759579, 37067.443988339655, 37341.25317493689, 37866.62133378631, 27265.59101613517, 27711.0, 27818.860905695343, 28175.71824281731, 28198.85900570484], "value": 20236.87665197371, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.8648066417085, 391.89222963684966, 402.9637332640063, 408.17141203357187, 424.83643797138114, 13505.290090588498, 17892.642147157065, 18013.36953206638, 19586.0, 19588.804111958878, 18902.0, 19150.712739308885, 19678.606427871433, 19746.0, 20008.399748007545, 5509.779608815653, 5551.528120109775, 5683.744231509571, 5704.1443783432405, 5721.856953576153, 5685.459881311269, 5692.57305702074, 5727.770889164429, 5733.140028995643, 5735.0, 5499.835004949838, 5642.57680673949, 5669.574781891375, 5673.432656734335, 5681.9431805681825, 5444.156155795858, 5622.943770562303, 5691.630044047124, 5702.087665973445, 5704.828855134353, 5059.3169922060415, 5089.05852417304, 5092.185250359962, 5098.694078355311, 5099.107656160157, 22822.0, 22991.31026069204, 23061.0, 23470.178543750888, 23817.404564885845, 2326.8836558172193, 2328.0571368595747, 2331.160782118436, 2343.4727186383097, 2363.2910126962015, 14792.11247325164, 14828.481003164838, 14841.628959275997, 15052.172130532816, 15435.691286174213, 1860.823221793941, 1894.4411398637435, 1914.7223652570437, 1975.5258737902943, 2001.3895761792648, 82947.0, 84000.0, 84158.57920710418, 84546.15453845444, 86785.0, 10418.895811041793, 10500.159987201005, 10864.891351086388, 11032.558697652164, 11038.779224415466, 13372.866271337356, 15318.234088295541, 15328.310226039855, 15369.231538423033, 15378.3079761411, 7229.819254518679, 7758.806029849299, 8037.959810200911, 8138.9186108138165, 8267.875981860278, 7750.534967901831, 8068.7175948841505, 8074.919250807534, 8080.515169089874, 8203.75388738327, 6601.2738598754095, 6612.2726500084955, 6635.900461493082, 6652.174999375282, 6684.398404143651, 1837.5222442165134, 1908.46562962368, 1923.8749481283671, 1950.697641865513, 1997.0813425823992, 852.4160949749441, 951.4196340232453, 988.2588058955783, 996.267743208741, 1006.4866917871792, 18251.087445627665, 19839.404817855488, 20199.596008079756, 20363.287284944956, 20520.281790137273, 993.5082134343546, 1000.3047881722279, 1005.0753306957616, 1038.3925403638805, 1051.9105876000472, 10559.968327023513, 11333.659990200307, 11379.846356079972, 11502.942485287687, 11605.709857253467, 500070.0, 500613.0, 506336.0, 513893.0, 519039.0, 84211.57894210612, 84356.57821710852, 86223.0, 87702.56148719216, 88278.0, 950.1068995144681, 960.519740129935, 994.6220436234184, 999.0858364596313, 1001.929864909464, 17268.827311727226, 17851.285948561912, 18326.26694932188, 18328.725069123706, 18354.449366519028, 40649.18701625892, 41362.37956430596, 41645.79177104095, 42207.577924220364, 42673.78663106789, 54160.45839541712, 54425.72787136039, 55306.72346638241, 56869.43130568641, 58263.0, 8020.035091402644, 8393.958030210055, 8461.576921154041, 8595.742127736177, 8600.881885354864, 13199.274039927512, 13224.603261902159, 13299.66750831237, 13300.46798128064, 13339.399727012114, 11347.37589432589, 11482.94258528702, 11605.187636865676, 11614.70963225926, 11825.349605771766, 10700.143988481059, 11056.502457389275, 11186.608468703556, 11236.26964247354, 11846.526138954345, 11942.582009629621, 11971.521139154336, 12047.096467765128, 12176.634700958986, 12220.694482638006, 8165.550894700848, 8319.750407487785, 8403.0, 8521.659133634834, 8614.483131012159, 10834.349939003685, 10930.726731831768, 11168.329900206014, 11225.719357015812, 11485.942570287096], "value": 9326.324793864516, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.152347926889, 1436.6623843396796, 1481.2223582619124, 1492.2389581313528, 1577.928993195306, 7890.960545197273, 8607.225349718532, 9007.459552426842, 9009.279257659397, 9243.95378023109, 9085.136911993366, 9165.0, 9168.358214924958, 9182.127697868691, 9183.0, 2377.2986968844148, 2408.494216214597, 2410.288964755401, 2415.3478560788576, 2430.9392265193424, 2312.6993490846253, 2313.4794671199015, 2365.2312998275543, 2374.442006128567, 2374.7625237476286, 2314.976850231493, 2362.7400985891536, 2371.8221133414977, 2391.485830546432, 2396.101461951768, 2284.6116160252795, 2300.3903965449085, 2306.550222706573, 2306.550222706573, 2336.6495025746276, 2311.8266130040315, 2312.4103353644714, 2315.5253173099472, 2320.9651855222187, 2321.721393432782, 8773.824523509558, 8970.102989700978, 9001.324900632479, 9050.0, 9060.77348066297, 4871.196252618313, 5066.670666406671, 5076.162433198518, 5084.542391184811, 5094.083065048289, 3177.380410819891, 3325.833708314575, 3378.797272163678, 3393.5588373511287, 3395.303962687643, 1058.9735256618646, 1074.978500429995, 1084.452351562456, 1099.6261271167841, 1106.3417266726285, 12441.129120961536, 12490.562830300896, 12565.057620678486, 12587.622371328875, 12689.619311420765, 4381.605655491021, 4505.977470112629, 4594.724316541018, 4615.976920115378, 4689.320048592935, 10030.699079027641, 10032.79934401308, 10035.247356448295, 10037.0, 10037.648682296085, 5151.330327057459, 5161.74191290434, 5165.974170129125, 5167.560757335594, 5183.196604526304, 4144.150449157915, 4266.893327666833, 4658.976705116453, 4783.521647835259, 4838.274258861199, 3704.3332200204222, 3797.715171362104, 3818.3508803503473, 3860.092878173627, 3870.4000879863665, 1162.203890335123, 1167.1246565076192, 1171.1099564331, 1176.0944073063692, 1200.8799120087922, 836.9497830130211, 941.1341565759518, 952.1668540027476, 955.7180631713661, 978.1245785022508, 5768.884622307531, 5884.205632239678, 5914.201582786355, 5991.5206783457215, 6094.847628809227, 466.91128685549637, 489.3149590573155, 489.42003725585295, 490.49724032866595, 492.05525391248887, 4074.4295798588223, 4157.667386609124, 4174.3321068628875, 4201.516825565038, 4203.789810509462, 10889.0, 11076.778464430667, 11136.944315278533, 11138.777224455465, 11148.777024459465, 10880.564777408816, 10946.0, 11016.449177541252, 11025.558977640805, 11034.889651103547, 7894.64474098667, 8124.187581241947, 8162.14297498766, 8185.263326300543, 8307.875381869277, 5956.3282253487605, 6006.849828754316, 6123.877522449437, 6153.27708241693, 6173.876522469615, 10192.949035254776, 10235.488225588542, 10294.639687610897, 10335.483225838829, 10423.166146708094, 10327.690169294932, 10469.267151299337, 10470.633527826489, 10539.841902371318, 10681.305715128492, 7290.198078211499, 7464.066991626047, 7466.0, 8028.357731381592, 8132.0, 8239.258466738022, 8319.542425166674, 8436.662533498591, 8733.301335892986, 8984.146506081912, 7857.253560911704, 7986.920130798618, 8022.398320125897, 8113.310368618733, 8293.129221431664, 7734.149243583314, 7858.371330293677, 7905.407094467823, 7945.960270198612, 8007.639656215368, 6977.441804655514, 7040.0847889774, 7042.260562640849, 7080.504364694422, 7090.64546772649, 5200.245964335226, 5279.47205279469, 5303.416624171261, 5306.071437498499, 5336.653117547347, 5198.726312053571, 5232.3982741985155, 5237.973810130925, 5276.947230527646, 5306.097963346163], "value": 4549.99546623088, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.79986408426777, 334.2829630442699, 336.8635702540471, 338.7577881814502, 344.66739596289574, 5057.544820966113, 5128.9230661540105, 5199.4800519947985, 5227.973860130699, 5238.835126074775, 5057.90097109699, 5095.261187127873, 5167.715775632339, 5167.896642067157, 5185.0, 4127.380892866079, 4128.256913755523, 4134.52452967908, 4145.419641250227, 4149.771762553059, 3987.4616926714957, 4101.79491025449, 4127.360259159835, 4146.709730318879, 4156.939980305018, 4102.256540970076, 4117.711760176789, 4119.423280740699, 4119.897002574945, 4153.460050193486, 4109.2808758467145, 4109.6712263019035, 4123.257813593552, 4135.234981528427, 4161.895952601179, 3681.263747250534, 3682.852685892588, 3684.7604905681046, 3694.8152592370275, 3703.2593481303848, 4987.202047672355, 5075.213341932006, 5094.337736094284, 5104.948950510485, 5106.208537676666, 4640.09518143962, 4670.743109128996, 4672.976635116803, 4685.88285292867, 4703.764811759433, 5386.596005299618, 5392.4337944515655, 5398.91901621476, 5406.459354064601, 5409.810656626999, 3814.1608846053823, 3947.4276229946495, 3948.368261078214, 3957.6438120569, 3962.801859907022, 5561.332640083176, 5595.832125036255, 5603.383627800898, 5620.213170156181, 5628.493435590816, 4058.5738497457933, 4079.714419990572, 4082.2447847148374, 4083.571225021389, 4096.774677392712, 4034.8789536313957, 4107.281225785476, 4127.380892866094, 4144.212599606065, 4144.3990621359735, 4622.884427889262, 4648.2562789953445, 4651.488336283006, 4659.370984917061, 4695.366125573072, 5420.159875219348, 5434.972825135928, 5435.211894275387, 5437.6346289364255, 5450.482204190595, 1312.7224265898658, 1342.234926092118, 1374.6700791809894, 1376.6214291069837, 1424.3732757586629, 904.2359206470522, 949.9810003800023, 954.4893481987103, 956.9952150239204, 962.5331714118647, 4687.671862969628, 4695.366125573004, 4695.577398034194, 4696.459907110658, 4709.246520556694, 4847.61842874779, 4879.707217566957, 4904.926426103611, 4907.705537667752, 4914.419929537022, 4589.954100458953, 4648.233041548175, 4681.765911704401, 4682.578567928903, 4725.0, 2724.768394686474, 2957.260684828793, 2960.1267626050367, 2965.1845742420574, 2967.2433529449854, 5723.5707321950185, 5762.30852297727, 5776.277965254343, 5809.24479817621, 5818.330891947396, 5484.957858006966, 5625.521830644441, 5670.489655930986, 5717.284814555616, 5745.885082298414, 5787.0, 5802.82591522255, 5807.245058142415, 5814.883702326015, 5819.6508209507565, 5609.186667933045, 5624.521915637217, 5634.859128521656, 5646.71766411686, 5650.745716442852, 5282.468084255523, 5546.916796248141, 5559.971405290034, 5595.496405323541, 5601.439856014366, 5821.505172060422, 5821.970890145522, 5840.912386314294, 5841.94158058431, 5881.73532191061, 3877.340852055214, 4046.43349931004, 4058.5738497458524, 4064.8577299794365, 4071.9389209162478, 5349.759260833194, 5586.40787375596, 5590.720463976866, 5595.804146854841, 5628.268325117709, 5218.173639226392, 5363.551841002985, 5430.755615997211, 5464.885015541262, 5467.0, 5446.21029950647, 5447.972760136174, 5454.754536045808, 5456.836294911159, 5468.371137319259, 5280.20796880471, 5408.405075441619, 5420.539254163283, 5426.620136590401, 5447.53695935834, 5459.590530710133, 5484.8354549363585, 5492.533134683436, 5498.725063746877, 5500.779968801203, 5380.461953804588, 5392.1372580388515, 5403.378611459575, 5404.32445944257, 5425.0], "value": 4142.145699061989, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.8075529229465, 744.9478536502444, 785.6739453126953, 788.2472239011744, 826.4545400035976, 12997.285149316784, 14079.240094988127, 14088.36602352894, 14088.71822563548, 14090.154590724564, 12414.0, 12443.875561244386, 12447.253164810118, 12461.563845265418, 12468.064895132857, 654.254150268694, 666.7499687617144, 773.4817672159638, 781.4998401023336, 785.9410544209208, 791.5290402210676, 791.6872835230081, 793.2662287384176, 793.274154148953, 793.3653077537975, 847.6185716427601, 847.7499137754377, 848.6944699908029, 848.7453763870814, 849.3417601358934, 692.4529621598956, 706.6784613001098, 829.5644786487082, 846.2595229174473, 848.4315508609246, 613.2548953022055, 616.1312549305458, 617.1606615003592, 617.305531277313, 617.5245061302817, 12938.417771200318, 12951.740965180737, 12966.740665186644, 12980.545680901218, 12981.610551683465, 13403.329833508285, 13472.5284615038, 13814.516491922734, 13817.170969741746, 14254.786178207336, 12529.812052819216, 12580.104701630227, 12585.433655485525, 12979.675508112372, 13046.608601741867, 4462.3752674625575, 4503.347014682885, 4513.571210734975, 4514.210013247669, 4548.772561371951, 80890.9053823462, 83120.58439707823, 83277.0, 84691.57654211689, 85514.0, 10177.389356638625, 10593.152547796159, 11547.133964952494, 11630.88369116298, 11840.33592441711, 17365.479035628952, 18551.44345669632, 18703.625927481375, 18745.343912963253, 18754.1560629772, 7321.341079302888, 7672.5012874163, 7741.651625676858, 7749.883751743729, 7806.0632724073475, 4252.978735106305, 4261.850835220815, 4325.891852703708, 4453.888652783707, 4474.32885067236, 3272.1655977726004, 3399.048266485388, 3412.283420481677, 3465.1163953191776, 3593.2993066352333, 614.6527212125135, 643.8486955565438, 645.4997377032837, 646.7219095788856, 647.5952529668957, 614.8032629558498, 639.9792331231678, 718.4749278051869, 726.894600282956, 737.3363972424753, 8770.3422243332, 9275.675351362805, 9325.300602454843, 9525.57134928916, 9644.614215431304, 626.6334194496179, 627.7018416252243, 648.9772857950044, 657.2671471309551, 662.9436497897733, 4223.704340696183, 4311.353297005474, 4346.348047792793, 4359.869203923888, 4576.130535198302, 78580.0, 92781.5360923191, 128600.35699821441, 129860.35069824591, 132872.0, 86175.0, 86814.0, 86974.0, 103470.0, 108507.45746271218, 59473.70263148743, 64572.0, 86588.13411865926, 87889.56055219682, 90398.0, 9340.078338703386, 10089.545970431202, 10099.545520451744, 10110.443925584164, 10115.342502737298, 51705.7414712924, 51990.48009520008, 52326.73836630792, 52330.47669523409, 53672.0, 70256.64871675608, 78191.0, 78668.0, 80366.0, 81685.18314816775, 12747.553835615709, 13117.437189690952, 13214.471421143047, 13262.734745305233, 14321.355539000562, 15238.542843714706, 15390.923045384701, 16210.918945405198, 16371.181440927669, 16825.91587042106, 11947.522099115939, 12070.818937716116, 12526.37368131608, 12560.43478043472, 12843.357832108544, 14041.438342466186, 14698.926505367404, 15133.167675777939, 15190.088594683912, 15285.465008724641, 11942.70143246391, 12269.93865030669, 12534.56129035516, 13249.735005300034, 13266.0, 10330.380177189392, 10487.161027117965, 10543.20925930543, 11305.943470282597, 11527.250728702607, 10258.846117308098, 11162.776744464903, 11265.576246596616, 11357.318560886373, 11454.942725286654], "value": 7342.980420855118, "unit": "score"}], "name": "dromaeo_css", "value": 7175.027844806007, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 111.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 118.0, 155.0, 121.0, 122.0, 118.0, 117.0, 146.0, 119.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 162.0, 162.0, 161.0, 160.0, 164.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 114.0, 77.0, 76.0, 76.0, 76.0, 112.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 118.0, 83.0, 83.0, 83.0, 105.0, 83.0, 82.0, 114.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 148.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 96.0, 96.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 52.0, 51.0, 53.0, 53.0, 53.0, 53.0, 59.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 60.0, 61.0, 67.0, 61.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 78.0, 82.0, 79.0, 79.0, 87.0, 79.0, 79.0, 79.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 126.0, 134.0, 124.0, 134.0, 125.0, 129.0, 130.0, 173.0, 126.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 167.0, 163.0, 164.0, 169.0, 167.0, 164.0, 169.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 73.0, 64.0, 66.0, 64.0, 66.0, 68.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1497.8999999999999, "alertThreshold": 2.0}]} 18:27:06 INFO - Return code: 0 18:27:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:27:07 INFO - # TBPL SUCCESS # 18:27:07 INFO - Running post-action listener: _resource_record_post_action 18:27:07 INFO - [mozharness: 2016-09-21 01:27:07.069682Z] Finished run-tests step (success) 18:27:07 INFO - Running post-run listener: _resource_record_post_run 18:27:07 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 1744896; Write bytes: 395014144; Read time: 68; Write time: 414340 18:27:07 INFO - TinderboxPrint: CPU usage
13.0% 18:27:07 INFO - TinderboxPrint: I/O read bytes / time
1,744,896 / 68 18:27:07 INFO - TinderboxPrint: I/O write bytes / time
395,014,144 / 414,340 18:27:07 INFO - TinderboxPrint: CPU idle
8,304.2 (86.9%) 18:27:07 INFO - TinderboxPrint: CPU user
1,192.3 (12.5%) 18:27:07 INFO - TinderboxPrint: Swap in / out
0 / 0 18:27:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106508288; Read time: 0; Write time: 152064 18:27:07 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287891456; Read time: 12; Write time: 262276 18:27:07 INFO - Running post-run listener: _upload_blobber_files 18:27:07 INFO - Blob upload gear active. 18:27:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:27:07 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 18:27:07 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'] 18:27:07 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 18:27:08 INFO - (blobuploader) - INFO - Open directory for files ... 18:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:11 INFO - (blobuploader) - INFO - Done attempting. 18:27:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:27:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:12 INFO - (blobuploader) - INFO - Done attempting. 18:27:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:27:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:27:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:13 INFO - (blobuploader) - INFO - Done attempting. 18:27:13 INFO - (blobuploader) - INFO - Iteration through files over. 18:27:13 INFO - Return code: 0 18:27:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:27:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:27:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f4fcfe50edfc70f4e6ad3cb56a7c6a85c9c34281249802092afddccd4d551c4a8a61c4ab5729812065f0a3de61bcd9124cdccb50bd5eca95661345f98738753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d6a9c2fb2d244907fbddbaa990f2e1d88974f6a79eb7991a6643a05aaab92d406eb406b26a3d634b7daa2b8450540de97898be7f6d320f9a4a5d054895e1f0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93e323925e657141cc9ebd6a5cdb93c95daf64f57805a3643e85261c79d8804c6bf8b87543ffd20f5aff75065503c59a37d28594e1f619b59b8e42eb120a313e"} 18:27:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:27:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:27:13 INFO - Contents: 18:27:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f4fcfe50edfc70f4e6ad3cb56a7c6a85c9c34281249802092afddccd4d551c4a8a61c4ab5729812065f0a3de61bcd9124cdccb50bd5eca95661345f98738753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d6a9c2fb2d244907fbddbaa990f2e1d88974f6a79eb7991a6643a05aaab92d406eb406b26a3d634b7daa2b8450540de97898be7f6d320f9a4a5d054895e1f0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93e323925e657141cc9ebd6a5cdb93c95daf64f57805a3643e85261c79d8804c6bf8b87543ffd20f5aff75065503c59a37d28594e1f619b59b8e42eb120a313e"} 18:27:13 INFO - Running post-run listener: copy_logs_to_upload_dir 18:27:13 INFO - Copying logs to upload dir... 18:27:13 INFO - mkdir: /builds/slave/test/build/upload/logs 18:27:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.510887 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-20 18:27:13.308862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 18:27:13.312400) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045 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/9f4fcfe50edfc70f4e6ad3cb56a7c6a85c9c34281249802092afddccd4d551c4a8a61c4ab5729812065f0a3de61bcd9124cdccb50bd5eca95661345f98738753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d6a9c2fb2d244907fbddbaa990f2e1d88974f6a79eb7991a6643a05aaab92d406eb406b26a3d634b7daa2b8450540de97898be7f6d320f9a4a5d054895e1f0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93e323925e657141cc9ebd6a5cdb93c95daf64f57805a3643e85261c79d8804c6bf8b87543ffd20f5aff75065503c59a37d28594e1f619b59b8e42eb120a313e"} build_url:https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/a3w2lcSmSgCBm1ZOsYCM2Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f4fcfe50edfc70f4e6ad3cb56a7c6a85c9c34281249802092afddccd4d551c4a8a61c4ab5729812065f0a3de61bcd9124cdccb50bd5eca95661345f98738753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d6a9c2fb2d244907fbddbaa990f2e1d88974f6a79eb7991a6643a05aaab92d406eb406b26a3d634b7daa2b8450540de97898be7f6d320f9a4a5d054895e1f0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93e323925e657141cc9ebd6a5cdb93c95daf64f57805a3643e85261c79d8804c6bf8b87543ffd20f5aff75065503c59a37d28594e1f619b59b8e42eb120a313e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 18:27:13.337993) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:27:13.338325) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1474419991.315562-1716807045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:27:13.423199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 18:27:13.423545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 18:27:13.423864) ========= ========= Total master_lag: 0.15 =========