builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1481806433.44 results: success (0) buildid: 20161215030215 builduid: 804a2738feba4f7f8d90de161e9e2950 revision: 7652a58efa46f1c57c94bba26efc5d53b6184e83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:53.441848) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:53.442303) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:53.442605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:53.466128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:53.466392) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 04:53:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.0M=0s 2016-12-15 04:53:54 (33.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:53.588935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:53.589233) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019054 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:53.638358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:53.638717) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7652a58efa46f1c57c94bba26efc5d53b6184e83 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7652a58efa46f1c57c94bba26efc5d53b6184e83 --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=9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 04:53:54,133 truncating revision to first 12 chars 2016-12-15 04:53:54,133 Setting DEBUG logging. 2016-12-15 04:53:54,133 attempt 1/10 2016-12-15 04:53:54,134 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7652a58efa46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 04:53:54,559 unpacking tar archive at: mozilla-central-7652a58efa46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.737568 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:54.389818) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:54.390127) ========= script_repo_revision: 7652a58efa46f1c57c94bba26efc5d53b6184e83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:54.390542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:54.390813) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 04:53:54.404085) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-12-15 04:53:54.404369) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:53:54 INFO - MultiFileLogger online at 20161215 04:53:54 in /builds/slave/test 04:53:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:53:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:53:54 INFO - {'append_to_log': False, 04:53:54 INFO - 'base_work_dir': '/builds/slave/test', 04:53:54 INFO - 'blob_upload_branch': 'Firefox', 04:53:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:53:54 INFO - 'branch': 'Firefox', 04:53:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:54 INFO - 'config_files': ('talos/linux_config.py',), 04:53:54 INFO - 'default_actions': ('clobber', 04:53:54 INFO - 'read-buildbot-config', 04:53:54 INFO - 'download-and-extract', 04:53:54 INFO - 'populate-webroot', 04:53:54 INFO - 'create-virtualenv', 04:53:54 INFO - 'install', 04:53:54 INFO - 'run-tests'), 04:53:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:54 INFO - 'download_minidump_stackwalk': True, 04:53:54 INFO - 'download_symbols': 'ondemand', 04:53:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:54 INFO - 'installer_path': 'installer.exe', 04:53:54 INFO - 'log_level': 'info', 04:53:54 INFO - 'log_name': 'talos', 04:53:54 INFO - 'log_to_console': True, 04:53:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:53:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:53:54 INFO - 'opt_config_files': (), 04:53:54 INFO - 'pip_index': False, 04:53:54 INFO - 'sps_profile': False, 04:53:54 INFO - 'sps_profile_interval': 0, 04:53:54 INFO - 'suite': 'dromaeojs', 04:53:54 INFO - 'system_bits': '32', 04:53:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:54 INFO - 'title': 'talos-linux64-ix-022', 04:53:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:54 INFO - 'use_talos_json': True, 04:53:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:53:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:54 INFO - 'work_dir': 'build'} 04:53:54 INFO - [mozharness: 2016-12-15 12:53:54.996100Z] Running clobber step. 04:53:54 INFO - Running pre-action listener: _resource_record_pre_action 04:53:54 INFO - Running main action method: clobber 04:53:54 INFO - rmtree: /builds/slave/test/build 04:53:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:53:55 INFO - Running post-action listener: _resource_record_post_action 04:53:55 INFO - [mozharness: 2016-12-15 12:53:55.456748Z] Finished clobber step (success) 04:53:55 INFO - [mozharness: 2016-12-15 12:53:55.456846Z] Running read-buildbot-config step. 04:53:55 INFO - Running pre-action listener: _resource_record_pre_action 04:53:55 INFO - Running main action method: read_buildbot_config 04:53:55 INFO - Using buildbot properties: 04:53:55 INFO - { 04:53:55 INFO - "project": "", 04:53:55 INFO - "product": "firefox", 04:53:55 INFO - "script_repo_revision": "production", 04:53:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:53:55 INFO - "repository": "", 04:53:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:53:55 INFO - "buildid": "20161215030215", 04:53:55 INFO - "stage_platform": "linux64-pgo", 04:53:55 INFO - "basedir": "/builds/slave/test", 04:53:55 INFO - "nightly_build": "True", 04:53:55 INFO - "buildnumber": 113, 04:53:55 INFO - "slavename": "talos-linux64-ix-022", 04:53:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:53:55 INFO - "platform": "ubuntu64_hw", 04:53:55 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:53:55 INFO - "branch": "mozilla-central", 04:53:55 INFO - "repo_path": "mozilla-central", 04:53:55 INFO - "revision": "7652a58efa46f1c57c94bba26efc5d53b6184e83", 04:53:55 INFO - "pgo_build": "True", 04:53:55 INFO - "builduid": "804a2738feba4f7f8d90de161e9e2950", 04:53:55 INFO - "slavebuilddir": "test" 04:53:55 INFO - } 04:53:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 04:53:55 INFO - Running post-action listener: _resource_record_post_action 04:53:55 INFO - [mozharness: 2016-12-15 12:53:55.459329Z] Finished read-buildbot-config step (success) 04:53:55 INFO - [mozharness: 2016-12-15 12:53:55.459417Z] Running download-and-extract step. 04:53:55 INFO - Running pre-action listener: _resource_record_pre_action 04:53:55 INFO - Running main action method: download_and_extract 04:53:55 INFO - mkdir: /builds/slave/test/build/tests 04:53:55 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')]} 04:53:55 INFO - trying https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:53:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:53:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:53:56 INFO - Downloaded 1361 bytes. 04:53:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:53:56 INFO - Using the following test package requirements: 04:53:56 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:53:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:53:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:56 INFO - u'jsshell-linux-x86_64.zip'], 04:53:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:53:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:53:56 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:53:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:53:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:53:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:53:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:53:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:53:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:53:57 INFO - Expected file size: 21775412 04:53:57 INFO - Obtained file size: 21775412 04:54:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:54:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:54:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:54:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:54:01 INFO - Expected file size: 21775412 04:54:01 INFO - Obtained file size: 21775412 04:54:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:54:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:54:08 INFO - Expected file size: 14409734 04:54:08 INFO - Obtained file size: 14409734 04:54:08 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')]} 04:54:08 INFO - trying https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:54:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:54:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:54:10 INFO - Downloaded 59901631 bytes. 04:54:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:54:10 INFO - mkdir: /builds/slave/test/properties 04:54:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:54:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:54:10 INFO - Contents: 04:54:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:54:11 INFO - Running post-action listener: _resource_record_post_action 04:54:11 INFO - Running post-action listener: set_extra_try_arguments 04:54:11 INFO - [mozharness: 2016-12-15 12:54:11.174932Z] Finished download-and-extract step (success) 04:54:11 INFO - [mozharness: 2016-12-15 12:54:11.175157Z] Running populate-webroot step. 04:54:11 INFO - Running pre-action listener: _resource_record_pre_action 04:54:11 INFO - Running main action method: populate_webroot 04:54:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:11 INFO - '--tppagecycles', 04:54:11 INFO - '7'], 04:54:11 INFO - 'tests': ['tsvgm']}}, 04:54:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:54:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:54:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:54:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['damp', 'tps']}, 04:54:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'tests': ['damp', 'tps']}, 04:54:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['dromaeo_dom']}, 04:54:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['basic_compositor_video']}, 04:54:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:54:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['tsvgx', 04:54:11 INFO - 'tsvgr_opacity', 04:54:11 INFO - 'tart', 04:54:11 INFO - 'tscrollx', 04:54:11 INFO - 'cart', 04:54:11 INFO - 'tsvg_static']}, 04:54:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:54:11 INFO - 'tsvgr_opacity', 04:54:11 INFO - 'tart', 04:54:11 INFO - 'tscrollx', 04:54:11 INFO - 'cart', 04:54:11 INFO - 'tsvg_static']}, 04:54:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['tp5o']}, 04:54:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:54:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'talos_options': ['--disable-e10s', 04:54:11 INFO - '--xperf_path', 04:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:11 INFO - 'tests': ['tp5n']}, 04:54:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'talos_options': ['--xperf_path', 04:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:11 INFO - 'tests': ['tp5n']}}, 04:54:11 INFO - 'talos.zip': {'path': '', 04:54:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:11 INFO - Running post-action listener: _resource_record_post_action 04:54:11 INFO - [mozharness: 2016-12-15 12:54:11.191955Z] Finished populate-webroot step (success) 04:54:11 INFO - [mozharness: 2016-12-15 12:54:11.192042Z] Running create-virtualenv step. 04:54:11 INFO - Running pre-action listener: _resource_record_pre_action 04:54:11 INFO - Running main action method: create_virtualenv 04:54:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:54:11 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 04:54:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:54:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:11 INFO - Using real prefix '/usr' 04:54:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:54:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:13 INFO - Installing pip.................done. 04:54:13 INFO - Return code: 0 04:54:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:54:13 INFO - Reading from file tmpfile_stdout 04:54:13 INFO - Output received: 04:54:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:54:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f105980fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', '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 04:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:54:13 INFO - Using env: {'DISPLAY': ':0', 04:54:13 INFO - 'HOME': '/home/cltbld', 04:54:13 INFO - 'LANG': 'en_US.UTF-8', 04:54:13 INFO - 'LANGUAGE': 'en_US:en', 04:54:13 INFO - 'LOGNAME': 'cltbld', 04:54:13 INFO - 'MAIL': '/var/mail/cltbld', 04:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:13 INFO - 'MOZ_NO_REMOTE': '1', 04:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:13 INFO - 'NO_EM_RESTART': '1', 04:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:13 INFO - 'PWD': '/builds/slave/test', 04:54:13 INFO - 'SHELL': '/bin/bash', 04:54:13 INFO - 'SHLVL': '1', 04:54:13 INFO - 'TERM': 'linux', 04:54:13 INFO - 'TMOUT': '86400', 04:54:13 INFO - 'USER': 'cltbld', 04:54:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:13 INFO - '_': '/tools/buildbot/bin/python'} 04:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:14 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 04:54:14 INFO - Cleaning up... 04:54:14 INFO - Return code: 0 04:54:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:54:14 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')]} 04:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:14 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')]} 04:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:14 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 0x7f105980fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', '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 04:54:14 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 04:54:14 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 04:54:14 INFO - Using env: {'DISPLAY': ':0', 04:54:14 INFO - 'HOME': '/home/cltbld', 04:54:14 INFO - 'LANG': 'en_US.UTF-8', 04:54:14 INFO - 'LANGUAGE': 'en_US:en', 04:54:14 INFO - 'LOGNAME': 'cltbld', 04:54:14 INFO - 'MAIL': '/var/mail/cltbld', 04:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:14 INFO - 'MOZ_NO_REMOTE': '1', 04:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:14 INFO - 'NO_EM_RESTART': '1', 04:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:14 INFO - 'PWD': '/builds/slave/test', 04:54:14 INFO - 'SHELL': '/bin/bash', 04:54:14 INFO - 'SHLVL': '1', 04:54:14 INFO - 'TERM': 'linux', 04:54:14 INFO - 'TMOUT': '86400', 04:54:14 INFO - 'USER': 'cltbld', 04:54:14 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:14 INFO - '_': '/tools/buildbot/bin/python'} 04:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:14 INFO - Downloading/unpacking psutil>=3.1.1 04:54:14 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 04:54:14 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 04:54:14 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 04:54:14 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 04:54:14 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 04:54:14 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 04:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:16 INFO - Installing collected packages: psutil 04:54:16 INFO - Running setup.py install for psutil 04:54:16 INFO - building 'psutil._psutil_linux' extension 04:54:16 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 04:54:16 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 04:54:16 INFO - building 'psutil._psutil_posix' extension 04:54:16 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 04:54:16 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 04:54:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:16 INFO - Successfully installed psutil 04:54:16 INFO - Cleaning up... 04:54:17 INFO - Return code: 0 04:54:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:54:17 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')]} 04:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:17 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')]} 04:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:17 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 0x7f105980fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', '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 04:54:17 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 04:54:17 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 04:54:17 INFO - Using env: {'DISPLAY': ':0', 04:54:17 INFO - 'HOME': '/home/cltbld', 04:54:17 INFO - 'LANG': 'en_US.UTF-8', 04:54:17 INFO - 'LANGUAGE': 'en_US:en', 04:54:17 INFO - 'LOGNAME': 'cltbld', 04:54:17 INFO - 'MAIL': '/var/mail/cltbld', 04:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:17 INFO - 'MOZ_NO_REMOTE': '1', 04:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:17 INFO - 'NO_EM_RESTART': '1', 04:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:17 INFO - 'PWD': '/builds/slave/test', 04:54:17 INFO - 'SHELL': '/bin/bash', 04:54:17 INFO - 'SHLVL': '1', 04:54:17 INFO - 'TERM': 'linux', 04:54:17 INFO - 'TMOUT': '86400', 04:54:17 INFO - 'USER': 'cltbld', 04:54:17 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:17 INFO - '_': '/tools/buildbot/bin/python'} 04:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:54:17 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 04:54:17 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 04:54:17 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 04:54:17 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 04:54:17 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 04:54:17 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 04:54:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:54:19 INFO - Installing collected packages: mozsystemmonitor 04:54:19 INFO - Running setup.py install for mozsystemmonitor 04:54:19 INFO - Successfully installed mozsystemmonitor 04:54:19 INFO - Cleaning up... 04:54:19 INFO - Return code: 0 04:54:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:54:19 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')]} 04:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:19 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')]} 04:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:19 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 0x7f105980fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', '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 04:54:19 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 04:54:19 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 04:54:19 INFO - Using env: {'DISPLAY': ':0', 04:54:19 INFO - 'HOME': '/home/cltbld', 04:54:19 INFO - 'LANG': 'en_US.UTF-8', 04:54:19 INFO - 'LANGUAGE': 'en_US:en', 04:54:19 INFO - 'LOGNAME': 'cltbld', 04:54:19 INFO - 'MAIL': '/var/mail/cltbld', 04:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:19 INFO - 'MOZ_NO_REMOTE': '1', 04:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:19 INFO - 'NO_EM_RESTART': '1', 04:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:19 INFO - 'PWD': '/builds/slave/test', 04:54:19 INFO - 'SHELL': '/bin/bash', 04:54:19 INFO - 'SHLVL': '1', 04:54:19 INFO - 'TERM': 'linux', 04:54:19 INFO - 'TMOUT': '86400', 04:54:19 INFO - 'USER': 'cltbld', 04:54:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:19 INFO - '_': '/tools/buildbot/bin/python'} 04:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:19 INFO - Downloading/unpacking jsonschema==2.5.1 04:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:54:21 INFO - warning: no files found matching '*.txt' 04:54:21 INFO - no previously-included directories found matching 'build' 04:54:21 INFO - no previously-included directories found matching 'dist' 04:54:21 INFO - no previously-included directories found matching '.git*' 04:54:21 INFO - Installing collected packages: jsonschema, functools32 04:54:21 INFO - Running setup.py install for functools32 04:54:22 INFO - warning: no files found matching '*.txt' 04:54:22 INFO - no previously-included directories found matching 'build' 04:54:22 INFO - no previously-included directories found matching 'dist' 04:54:22 INFO - no previously-included directories found matching '.git*' 04:54:22 INFO - Successfully installed jsonschema functools32 04:54:22 INFO - Cleaning up... 04:54:22 INFO - Return code: 0 04:54:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:54:22 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')]} 04:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:22 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')]} 04:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:22 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 0x7f105980fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', '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 04:54:22 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 04:54:22 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 04:54:22 INFO - Using env: {'DISPLAY': ':0', 04:54:22 INFO - 'HOME': '/home/cltbld', 04:54:22 INFO - 'LANG': 'en_US.UTF-8', 04:54:22 INFO - 'LANGUAGE': 'en_US:en', 04:54:22 INFO - 'LOGNAME': 'cltbld', 04:54:22 INFO - 'MAIL': '/var/mail/cltbld', 04:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:22 INFO - 'MOZ_NO_REMOTE': '1', 04:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:22 INFO - 'NO_EM_RESTART': '1', 04:54:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:22 INFO - 'PWD': '/builds/slave/test', 04:54:22 INFO - 'SHELL': '/bin/bash', 04:54:22 INFO - 'SHLVL': '1', 04:54:22 INFO - 'TERM': 'linux', 04:54:22 INFO - 'TMOUT': '86400', 04:54:22 INFO - 'USER': 'cltbld', 04:54:22 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:22 INFO - '_': '/tools/buildbot/bin/python'} 04:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:54:22 INFO - Cleaning up... 04:54:22 INFO - Return code: 0 04:54:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:54:22 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')]} 04:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:22 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')]} 04:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:22 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 0x7f105980fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', '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 04:54:22 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 04:54:22 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 04:54:22 INFO - Using env: {'DISPLAY': ':0', 04:54:22 INFO - 'HOME': '/home/cltbld', 04:54:22 INFO - 'LANG': 'en_US.UTF-8', 04:54:22 INFO - 'LANGUAGE': 'en_US:en', 04:54:22 INFO - 'LOGNAME': 'cltbld', 04:54:22 INFO - 'MAIL': '/var/mail/cltbld', 04:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:22 INFO - 'MOZ_NO_REMOTE': '1', 04:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:22 INFO - 'NO_EM_RESTART': '1', 04:54:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:22 INFO - 'PWD': '/builds/slave/test', 04:54:22 INFO - 'SHELL': '/bin/bash', 04:54:22 INFO - 'SHLVL': '1', 04:54:22 INFO - 'TERM': 'linux', 04:54:22 INFO - 'TMOUT': '86400', 04:54:22 INFO - 'USER': 'cltbld', 04:54:22 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:22 INFO - '_': '/tools/buildbot/bin/python'} 04:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:54:22 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 04:54:22 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 04:54:22 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 04:54:22 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 04:54:22 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 04:54:22 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 04:54:24 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:54:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54:25 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 04:54:25 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 04:54:25 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 04:54:25 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 04:54:25 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 04:54:25 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 04:54:25 INFO - Downloading docopt-0.6.1.tar.gz 04:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:54:25 INFO - Installing collected packages: blobuploader, requests, docopt 04:54:25 INFO - Running setup.py install for blobuploader 04:54:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:54:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:54:25 INFO - Running setup.py install for requests 04:54:25 INFO - Running setup.py install for docopt 04:54:25 INFO - Successfully installed blobuploader requests docopt 04:54:25 INFO - Cleaning up... 04:54:25 INFO - Return code: 0 04:54:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:25 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')]} 04:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:25 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')]} 04:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:25 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 0x7f105980fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', '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 04:54:25 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 04:54:25 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 04:54:25 INFO - Using env: {'DISPLAY': ':0', 04:54:25 INFO - 'HOME': '/home/cltbld', 04:54:25 INFO - 'LANG': 'en_US.UTF-8', 04:54:25 INFO - 'LANGUAGE': 'en_US:en', 04:54:25 INFO - 'LOGNAME': 'cltbld', 04:54:25 INFO - 'MAIL': '/var/mail/cltbld', 04:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:25 INFO - 'MOZ_NO_REMOTE': '1', 04:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:25 INFO - 'NO_EM_RESTART': '1', 04:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:25 INFO - 'PWD': '/builds/slave/test', 04:54:25 INFO - 'SHELL': '/bin/bash', 04:54:25 INFO - 'SHLVL': '1', 04:54:25 INFO - 'TERM': 'linux', 04:54:25 INFO - 'TMOUT': '86400', 04:54:25 INFO - 'USER': 'cltbld', 04:54:25 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:25 INFO - '_': '/tools/buildbot/bin/python'} 04:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:26 INFO - Running setup.py (path:/tmp/pip-ngIG0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:26 INFO - Running setup.py (path:/tmp/pip-64ZTT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:26 INFO - Running setup.py (path:/tmp/pip-AudERu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:26 INFO - Running setup.py (path:/tmp/pip-we2JWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:26 INFO - Running setup.py (path:/tmp/pip-9DIb2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:26 INFO - Running setup.py (path:/tmp/pip-tokCFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:26 INFO - Running setup.py (path:/tmp/pip-BAvhv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:26 INFO - Running setup.py (path:/tmp/pip-_0Lwmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:26 INFO - Running setup.py (path:/tmp/pip-XRGv5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:26 INFO - Running setup.py (path:/tmp/pip-15zIub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:26 INFO - Running setup.py (path:/tmp/pip-8evG8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:26 INFO - Running setup.py (path:/tmp/pip-0ANslC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:27 INFO - Running setup.py (path:/tmp/pip-sdEkrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:27 INFO - Running setup.py (path:/tmp/pip-B1JZGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:27 INFO - Running setup.py (path:/tmp/pip-kist2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:27 INFO - Running setup.py (path:/tmp/pip-EcDGXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:27 INFO - Running setup.py (path:/tmp/pip-uvoNR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:27 INFO - Running setup.py install for manifestparser 04:54:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:54:27 INFO - Running setup.py install for mozcrash 04:54:27 INFO - Running setup.py install for mozdebug 04:54:27 INFO - Running setup.py install for mozdevice 04:54:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:54:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:54:27 INFO - Running setup.py install for mozfile 04:54:27 INFO - Running setup.py install for mozhttpd 04:54:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozinfo 04:54:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozInstall 04:54:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozleak 04:54:28 INFO - Running setup.py install for mozlog 04:54:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for moznetwork 04:54:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozprocess 04:54:28 INFO - Running setup.py install for mozprofile 04:54:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozrunner 04:54:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozscreenshot 04:54:28 INFO - Running setup.py install for moztest 04:54:29 INFO - Running setup.py install for mozversion 04:54:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:29 INFO - Cleaning up... 04:54:29 INFO - Return code: 0 04:54:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:29 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')]} 04:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:29 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')]} 04:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:29 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 0x7f105980fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', '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 04:54:29 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 04:54:29 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 04:54:29 INFO - Using env: {'DISPLAY': ':0', 04:54:29 INFO - 'HOME': '/home/cltbld', 04:54:29 INFO - 'LANG': 'en_US.UTF-8', 04:54:29 INFO - 'LANGUAGE': 'en_US:en', 04:54:29 INFO - 'LOGNAME': 'cltbld', 04:54:29 INFO - 'MAIL': '/var/mail/cltbld', 04:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:29 INFO - 'MOZ_NO_REMOTE': '1', 04:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:29 INFO - 'NO_EM_RESTART': '1', 04:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:29 INFO - 'PWD': '/builds/slave/test', 04:54:29 INFO - 'SHELL': '/bin/bash', 04:54:29 INFO - 'SHLVL': '1', 04:54:29 INFO - 'TERM': 'linux', 04:54:29 INFO - 'TMOUT': '86400', 04:54:29 INFO - 'USER': 'cltbld', 04:54:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:29 INFO - '_': '/tools/buildbot/bin/python'} 04:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:29 INFO - Running setup.py (path:/tmp/pip-YZo8QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:29 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)) 04:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:29 INFO - Running setup.py (path:/tmp/pip-vWfxos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:29 INFO - Running setup.py (path:/tmp/pip-s7F6OU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:29 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)) 04:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:29 INFO - Running setup.py (path:/tmp/pip-WdkucK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:29 INFO - Running setup.py (path:/tmp/pip-BjSoKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:29 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)) 04:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:29 INFO - Running setup.py (path:/tmp/pip-ARZoav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:29 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)) 04:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:29 INFO - Running setup.py (path:/tmp/pip-Ervj_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:29 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)) 04:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:29 INFO - Running setup.py (path:/tmp/pip-b1YTX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:30 INFO - Running setup.py (path:/tmp/pip-ocbV2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:30 INFO - Running setup.py (path:/tmp/pip-41g7lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:30 INFO - Running setup.py (path:/tmp/pip-0ZWbBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:30 INFO - Running setup.py (path:/tmp/pip-6kH_Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:30 INFO - Running setup.py (path:/tmp/pip-UCtfW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:30 INFO - Running setup.py (path:/tmp/pip-IxgCSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:30 INFO - Running setup.py (path:/tmp/pip-PdtnNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:30 INFO - Running setup.py (path:/tmp/pip-kieLcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:30 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)) 04:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:30 INFO - Running setup.py (path:/tmp/pip-U8sSOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:30 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)) 04:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:54:30 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)) 04:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:54:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:30 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 04:54:30 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 04:54:30 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 04:54:30 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 04:54:30 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 04:54:30 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 04:54:32 INFO - Downloading blessings-1.6.tar.gz 04:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:32 INFO - Installing collected packages: blessings 04:54:32 INFO - Running setup.py install for blessings 04:54:32 INFO - Successfully installed blessings 04:54:32 INFO - Cleaning up... 04:54:32 INFO - Return code: 0 04:54:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:54:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:33 INFO - Reading from file tmpfile_stdout 04:54:33 INFO - Current package versions: 04:54:33 INFO - argparse == 1.2.1 04:54:33 INFO - blessings == 1.6 04:54:33 INFO - blobuploader == 1.2.4 04:54:33 INFO - docopt == 0.6.1 04:54:33 INFO - functools32 == 3.2.3-2 04:54:33 INFO - jsonschema == 2.5.1 04:54:33 INFO - manifestparser == 1.1 04:54:33 INFO - mozInstall == 1.12 04:54:33 INFO - mozcrash == 1.0 04:54:33 INFO - mozdebug == 0.1 04:54:33 INFO - mozdevice == 0.49 04:54:33 INFO - mozfile == 1.2 04:54:33 INFO - mozhttpd == 0.7 04:54:33 INFO - mozinfo == 0.9 04:54:33 INFO - mozleak == 0.1 04:54:33 INFO - mozlog == 3.4 04:54:33 INFO - moznetwork == 0.27 04:54:33 INFO - mozprocess == 0.23 04:54:33 INFO - mozprofile == 0.28 04:54:33 INFO - mozrunner == 6.13 04:54:33 INFO - mozscreenshot == 0.1 04:54:33 INFO - mozsystemmonitor == 0.3 04:54:33 INFO - moztest == 0.7 04:54:33 INFO - mozversion == 1.4 04:54:33 INFO - psutil == 3.1.1 04:54:33 INFO - requests == 1.2.3 04:54:33 INFO - wsgiref == 0.1.2 04:54:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:33 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 0x7f105980fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', '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 04:54:33 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 04:54:33 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 04:54:33 INFO - Using env: {'DISPLAY': ':0', 04:54:33 INFO - 'HOME': '/home/cltbld', 04:54:33 INFO - 'LANG': 'en_US.UTF-8', 04:54:33 INFO - 'LANGUAGE': 'en_US:en', 04:54:33 INFO - 'LOGNAME': 'cltbld', 04:54:33 INFO - 'MAIL': '/var/mail/cltbld', 04:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:33 INFO - 'MOZ_NO_REMOTE': '1', 04:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:33 INFO - 'NO_EM_RESTART': '1', 04:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:33 INFO - 'PWD': '/builds/slave/test', 04:54:33 INFO - 'SHELL': '/bin/bash', 04:54:33 INFO - 'SHLVL': '1', 04:54:33 INFO - 'TERM': 'linux', 04:54:33 INFO - 'TMOUT': '86400', 04:54:33 INFO - 'USER': 'cltbld', 04:54:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:33 INFO - '_': '/tools/buildbot/bin/python'} 04:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:33 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)) 04:54:33 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)) 04:54:33 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)) 04:54:33 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)) 04:54:33 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)) 04:54:33 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)) 04:54:33 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)) 04:54:33 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)) 04:54:33 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)) 04:54:33 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)) 04:54:33 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)) 04:54:33 INFO - Cleaning up... 04:54:33 INFO - Return code: 0 04:54:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f105980fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', '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 04:54:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:54:33 INFO - Using env: {'DISPLAY': ':0', 04:54:33 INFO - 'HOME': '/home/cltbld', 04:54:33 INFO - 'LANG': 'en_US.UTF-8', 04:54:33 INFO - 'LANGUAGE': 'en_US:en', 04:54:33 INFO - 'LOGNAME': 'cltbld', 04:54:33 INFO - 'MAIL': '/var/mail/cltbld', 04:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:33 INFO - 'MOZ_NO_REMOTE': '1', 04:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:33 INFO - 'NO_EM_RESTART': '1', 04:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:33 INFO - 'PWD': '/builds/slave/test', 04:54:33 INFO - 'SHELL': '/bin/bash', 04:54:33 INFO - 'SHLVL': '1', 04:54:33 INFO - 'TERM': 'linux', 04:54:33 INFO - 'TMOUT': '86400', 04:54:33 INFO - 'USER': 'cltbld', 04:54:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:33 INFO - '_': '/tools/buildbot/bin/python'} 04:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:54:33 INFO - Cleaning up... 04:54:33 INFO - Return code: 0 04:54:33 INFO - Running post-action listener: _resource_record_post_action 04:54:33 INFO - Running post-action listener: _start_resource_monitoring 04:54:33 INFO - Starting resource monitoring. 04:54:33 INFO - [mozharness: 2016-12-15 12:54:33.601533Z] Finished create-virtualenv step (success) 04:54:33 INFO - [mozharness: 2016-12-15 12:54:33.602053Z] Running install step. 04:54:33 INFO - Running pre-action listener: _resource_record_pre_action 04:54:33 INFO - Running main action method: install 04:54:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:33 INFO - Reading from file tmpfile_stdout 04:54:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:33 INFO - Reading from file tmpfile_stdout 04:54:33 INFO - Output received: 04:54:33 INFO - Usage: mozinstall [options] installer 04:54:33 INFO - Options: 04:54:33 INFO - -h, --help show this help message and exit 04:54:33 INFO - -d DEST, --destination=DEST 04:54:33 INFO - Directory to install application into. [default: 04:54:33 INFO - "/builds/slave/test"] 04:54:33 INFO - --app=APP Application being installed. [default: firefox] 04:54:33 INFO - mkdir: /builds/slave/test/build/application 04:54:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:54:50 INFO - Reading from file tmpfile_stdout 04:54:50 INFO - Output received: 04:54:50 INFO - /builds/slave/test/build/application/firefox/firefox 04:54:50 INFO - Running post-action listener: _resource_record_post_action 04:54:50 INFO - [mozharness: 2016-12-15 12:54:50.884148Z] Finished install step (success) 04:54:50 INFO - [mozharness: 2016-12-15 12:54:50.884389Z] Running run-tests step. 04:54:50 INFO - Running pre-action listener: _resource_record_pre_action 04:54:50 INFO - Running main action method: run_tests 04:54:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:50 INFO - Python 2.7.3 04:54:50 INFO - Return code: 0 04:54:50 INFO - grabbing minidump binary from tooltool 04:54: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')]} 04:54:50 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 0x2c33f20>, '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 0x2ba0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:50 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 04:54:50 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 04:54:50 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 04:54:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:50 INFO - Return code: 0 04:54:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:54:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:54:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 04:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 04:54:50 INFO - Using env: {'DISPLAY': ':0', 04:54:50 INFO - 'HOME': '/home/cltbld', 04:54:50 INFO - 'LANG': 'en_US.UTF-8', 04:54:50 INFO - 'LANGUAGE': 'en_US:en', 04:54:50 INFO - 'LOGNAME': 'cltbld', 04:54:50 INFO - 'MAIL': '/var/mail/cltbld', 04:54:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:50 INFO - 'MOZ_NO_REMOTE': '1', 04:54:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:50 INFO - 'NO_EM_RESTART': '1', 04:54:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:50 INFO - 'PWD': '/builds/slave/test', 04:54:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:50 INFO - 'SHELL': '/bin/bash', 04:54:50 INFO - 'SHLVL': '1', 04:54:50 INFO - 'TERM': 'linux', 04:54:50 INFO - 'TMOUT': '86400', 04:54:50 INFO - 'USER': 'cltbld', 04:54:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621', 04:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:50 INFO - '_': '/tools/buildbot/bin/python'} 04:54:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 04:54:51 INFO - mozversion application_buildid: 20161215030215 04:54:51 INFO - mozversion application_changeset: 7652a58efa46f1c57c94bba26efc5d53b6184e83 04:54:51 INFO - mozversion application_display_name: Nightly 04:54:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:51 INFO - mozversion application_name: Firefox 04:54:51 INFO - mozversion application_remotingname: firefox 04:54:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:54:51 INFO - mozversion application_vendor: Mozilla 04:54:51 INFO - mozversion application_version: 53.0a1 04:54:51 INFO - mozversion platform_buildid: 20161215030215 04:54:51 INFO - mozversion platform_changeset: 7652a58efa46f1c57c94bba26efc5d53b6184e83 04:54:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:54:51 INFO - mozversion platform_version: 53.0a1 04:54:51 INFO - using testdate: 1481806491 04:54:51 INFO - actual date: 1481806491 04:54:51 INFO - starting webserver on 'localhost:52379' 04:54:51 INFO - SUITE-START | Running 2 tests 04:54:51 INFO - TEST-START | dromaeo_css 04:54:51 INFO - operating with platform_type : linux_ 04:54:51 INFO - Initialising browser for dromaeo_css test... 04:54:51 INFO - TEST-INFO | started process 24299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpevLcpd/profile http://localhost:52379/getInfo.html) 04:54:55 INFO - PROCESS | 24299 | __metrics Screen width/height:1600/1200 04:54:55 INFO - PROCESS | 24299 | colorDepth:24 04:54:55 INFO - PROCESS | 24299 | Browser inner width/height: 1024/697 04:54:55 INFO - PROCESS | 24299 | __metrics 04:54:55 INFO - PROCESS | 24299 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:54:55 INFO - PROCESS | 24299 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:54:56 INFO - PROCESS | 24299 | console.error: PushService: 04:54:56 INFO - PROCESS | 24299 | stateChangeProcessEnqueue: Error transitioning state 04:54:56 INFO - PROCESS | 24299 | UnknownError 04:54:57 INFO - TEST-INFO | 24299: exit 0 04:54:57 INFO - Browser initialized. 04:54:57 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:57 INFO - TEST-INFO | started process 24381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpevLcpd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:09 INFO - PROCESS | 24381 | RSS: Main: 172228608 04:55:09 INFO - PROCESS | 24381 | 04:56:00 INFO - PROCESS | 24381 | 1481806560265 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] 04:58:10 INFO - PROCESS | 24381 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52379/tests/dromaeo/cssquery-ext.html) 04:58:12 INFO - PROCESS | 24381 | RSS: Main: 398286848 04:58:12 INFO - PROCESS | 24381 | 05:01:15 INFO - PROCESS | 24381 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-ext.html (next: http://localhost:52379/tests/dromaeo/cssquery-jquery.html) 05:01:16 INFO - PROCESS | 24381 | RSS: Main: 297218048 05:01:16 INFO - PROCESS | 24381 | 05:04:18 INFO - PROCESS | 24381 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52379/tests/dromaeo/cssquery-mootools.html) 05:04:18 INFO - PROCESS | 24381 | RSS: Main: 222748672 05:04:18 INFO - PROCESS | 24381 | 05:07:21 INFO - PROCESS | 24381 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52379/tests/dromaeo/cssquery-prototype.html) 05:07:21 INFO - PROCESS | 24381 | RSS: Main: 221544448 05:07:21 INFO - PROCESS | 24381 | 05:10:24 INFO - PROCESS | 24381 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52379/tests/dromaeo/cssquery-yui.html) 05:10:25 INFO - PROCESS | 24381 | RSS: Main: 222076928 05:10:25 INFO - PROCESS | 24381 | 05:13:27 INFO - PROCESS | 24381 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-yui.html (next: http://localhost:52379/tests/dromaeo/cssquery-dojo.html) 05:13:27 INFO - PROCESS | 24381 | RSS: Main: 315138048 05:13:27 INFO - PROCESS | 24381 | 05:13:27 INFO - PROCESS | 24381 | __start_tp_report 05:13:27 INFO - PROCESS | 24381 | _x_x_mozilla_page_load 05:13:27 INFO - PROCESS | 24381 | _x_x_mozilla_page_load_details 05:13:27 INFO - PROCESS | 24381 | |i|pagename|runs| 05:13:27 INFO - PROCESS | 24381 | |0;dojo.html;3065.203047207726;3089.5674605555214;3103.813771173728;3106.9689303106975;3112.1752735525083;5134.589232861372;5188.8702782430455;5350.5184533391985;5367.543758780504;5434.1305391137375;5248.763805628746;5355.3305836770405;5427.83716488506;5429.782808687658;5473.67157970522;4842.176829938919;4868.221084626461;4905.607551395879;4907.362042934414;4945.579625731799;4890.633202509808;4973.254011898208;4995.0509403213455;5004.199328107504;5047.369078865142;4959.727215003173;4976.726280054596;4993.875153121183;5041.395032596093;5064.417591976915;4774.761261936924;4809.783559739785;4814.422269327668;4855.393075865517;4874.878128046792;4826;4829.251466022737;4837.298591704219;4840.443349014873;4847.660663753539;5263.499967503081;5327.147656374961;5330.28041214435;5334.3598768147685;5343.305370301875;5675.744591493392;5688.544916406678;5688.5733569982;5689.345725241609;5700.144978253254;5705.74324155414;5721.542276617861;5727.513161381287;5729.799457018984;5731.828045158652;5309.177077552986;5337.172738225542;5346.465353464661;5351.384590772033;5356.91964620531;5729.28383952006;5729.88540229193;5748.223989761413;5766.308043034863;5813.7383817728305;5589.105743081088;5590.832275031756;5592.748326325243;5597.720113994284;5604.299462567179;5501.697406642673;5543.085390910454;5543.805966791143;5671;5677.205191273225;5655.660660360391;5700.116481945305;5708.686022268732;5748.511376533042;5779.49733069405;5778.797742079007;5778.884422311614;5788.652680839079;5789.421057894177;5824.970875145682;4285.5928686774705;4443.555644435595;4443.577860103285;4445.310976798602;4488.730676159375;3864.9806750966063;3897.493325867619;3904.4338570907057;3914.8629797957506;3928.4107383892647;5436.157395603609;5449.945500545023;5487.012337779158;5493.176023596413;5493.670379777146;5699.5725320600295;5704.857378565569;5722.227499287626;5722.828315150552;5746.655200687972;5233.842984710464;5251.684898906002;5412;5421.295231619864;5459.071957767189;4907.411110666742;4951.306817045616;4967.105920934194;4979.427365852901;5036.06832735945;5875.794347197828;5913.674747888907;5924;5927.31835838884;5930.525557955353;5562.582806289463;5737.713114344349;5742.971285143548;5744.0522313817755;5747.1379293106365;5705.572082093777;5905.143754155538;5905.9959806832085;5914.2311499504785;6028.5177185825905;5711.742971566373;5722.4277572242445;5723.914141287967;5731.197632331394;5731.799387021601;5700.857478563069;5795.043817770021;5798.85502862415;5807.593468457168;5824.039033559416;5447.346318441812;5494.2857428534035;5494.670319780826;5561.777528898961;5575.776968921197;5504.22940788298;5542.418046105101;5548.112302031655;5552.917181149637;5553.555715542666;5468.72656367188;5475.698836564027;5480.808171713971;5482.506574408322;5483.287172667528;5577.051901176728;5581.609287349846;5595.104783234826;5595.132754423071;5596.552275817843;5479.123340265538;5485.396606373375;5490.917636235539;5491.533219676372;5493.6978466183145 05:13:27 INFO - PROCESS | 24381 | |1;ext.html;561.8820047789964;578.459140703442;579.5132089045204;584.7427132061893;596.1147695671929;40208.39687404688;41653.375199372036;41936.161276774445;45626.771866140705;45629;43571.78214108933;44055.559444405546;44063.33904991428;44097;44250.55749442505;7904.446688731791;8117.756467305991;8580.742577722678;8735.388522803407;8747.431416957908;9967.850482242737;10263.281570290083;10271.229657775659;10576.10103141234;10577.36535807854;10374.533146008447;10440.947795261012;10454.790904181911;10455.4772261387;10458;10211.540480678388;10269.332493387943;10271.948640256825;10281.948590257076;10286.331388459726;10139.391636501834;10192;10208.132308753764;10209.642662506776;10216.795664086676;40426.19147617031;40758.18483630311;40808.38787418191;40820;40828.59171408277;3476.3394954958476;3518.5074089627474;3587.802670853102;3779.4708740776036;3813.80930953454;30037.849810751024;30128.09615711532;30335.241618959702;30337.848310758305;30866.228344291347;4031.6746117481703;4129.194807012634;4133.235351459959;4145.813438395279;4179.958200417987;322084;322448;322778;323641.9999999977;323908;51488.48511514912;51830.22254666183;52244.738776306636;52321.7383913078;58883.70558147268;54993;55063.44936550663;55192;55207.44792552103;55270.44729552734;14997.250137493082;15328.846711532742;15342.769858452131;15350.07899526032;15355.385784568492;11107.722306942229;11319.886801132048;11723.472443740053;11970.024945884006;12290.139690221598;17580.648387032186;17884.55288617795;17986.19062142207;17999.2800287987;18109.7283540747;5746.224259724967;5773.134029895549;5773.422657734277;5845.795397161079;5927.436893495111;889.7953470701775;1066.424130969268;1071.892810718922;1078.7626722121122;1104.2987702808775;30752.69247307543;30881;31166.844165779024;31466.528002079987;31675.20811979719;1029.53156313877;1061.9681409557725;1077.8975997280245;1106.9169812264113;1124.6457365929707;15595;16269.430569930233;16330.183490825411;16512.504624861274;16635.251413686412;449868;450381;451878;452051;452718;57392.13911791326;57651.423485765445;57659.71170144122;57705.42294577084;57721.4227857716;1202.2305724336431;1242.589945318043;1242.67069226655;1328.6014195741238;1336.8195293635235;30174;34125.31749365049;34364.31271374608;34462.1045842481;34474.31051378908;55522;55964.16053759278;56011;56296.43703562912;56353.71823140858;457142;458787;460686;461064;464339;34635.307293853475;35040;35917;36037.09907252339;41181;43761.56238437702;44072.55927440813;44386.77806611075;45478.77260613808;45549.54450455453;36767.63232367642;36970.44544331891;37671;37687.2462550742;39048.41427378535;36723.63276367202;37225.90515043289;37355;37597.248055039294;38008.619913801616;37495.81252093722;37631.62368376281;38193.618063819005;38251.426228607146;38268.80865595654;30042.849785750932;33612.327753445286;33883.66116338805;33978.150546235556;33990.32019359648;25533.3616659585;25787.742122578533;26148.73851261463;26151;26272.60591091097 05:13:27 INFO - PROCESS | 24381 | |2;jquery.html;381.1842656714631;386.1751289318636;386.83559487217934;392.7309792791938;415.1572308214326;14312.499062532814;15016.324265408055;17311.047892365914;18715.906420467894;18747.718784218247;16982.915085424556;17097;17123.657526849485;17363.218655160515;18106.90946545269;5486.972565137169;5510.531604813596;5691.800786972457;5733.397993210715;5742.425757424245;5556.194351818984;5675.602707810455;5683.914741278884;5685.744141513642;5686.744096515646;5408.404520666413;5519.199716041172;5607.691576963265;5653.632513886584;5655.4061823508555;5570.498655121039;5613.186088017214;5622.072358060936;5623.212750214973;5623.409541998092;4843.975780121077;5017.122003649383;5030.2957585938;5043.394792624872;5049.722265275408;18184;18274.36039738616;18942.810571894242;21360.145594176214;21667;2145.914163433461;2410.3853517353136;2423.903043878243;2488.925332240036;2888.5522743974716;9571.664991725325;9699.369540979813;9942.204623630092;9950;10202.183825293958;1857.823506766855;1958.392898201562;1971.2312198242696;1975.2790231565518;1985.8907760073191;72578;74033.6298318505;76723;78343;78684.21315786826;10562;10627.734306642242;10652.893471065345;10948.507317170746;10987.835182472269;13199.274039927896;14686.41254349814;14798.852011479747;14801.111933283823;14825.481108161162;6958.416415545998;7434.888476672854;7741.61291935401;7751.92248077512;7853.253940875607;7086.078809754699;7217.783575194254;7226.66306733256;7349.265073492608;7377.4098072155175;4507;4560.840370587013;4561.407017087758;4566.543345665407;4681.602063824613;1889.8015708350424;1908.1508728615634;1930.903454827253;1946.8345190658952;1973.2600274896913;812.4312980913385;939.3002213351098;974.468914441631;980.0983095552109;1011.2567263061644;17614.383496577557;18395.63208735818;18917.81082189188;19047.42857714271;19194;968.6173961285253;974.4153507895206;998.1415982255255;1001.4191768774093;1008.6973907827622;8025.719099831478;9827.4103553787;10091.340154729223;10701.678949631523;10844.457777111113;311810;428438;432445;435901;443559;91555;92998.53500732454;94281.52859235796;94544.52727736317;94950.52524737333;948.1608776233084;988.851672249154;993.8658281132099;994.6419289055934;1006.0492834271544;15147.924260378628;16294.592635184215;16971.490855274362;17141.657166856843;17188.570285742957;37703;38946.4158037624;39564;40515;41655.37516937188;53428.1985770206;53519.46480535145;53621.463785361644;54112.729436352565;55087.44912550823;7747.883781743166;8102;8124.959375203086;8410.116937721696;8448.40861139739;11306.94346528262;11886.405679716152;12251.938740306241;12291.815622765487;12760.361981901053;10307.94846025765;10527.263091583822;10560.419176945341;10919;11158.832617510581;10727.195460340661;10768.892311076788;10902.727431814268;10922.399268040333;11290.887091128983;10794.622188223375;10813.297135686154;10875.673729788119;11056.502457389275;11477.942610286895;8022.077461092049;8217.219364160395;8236.917630823855;8504.574771261536;8557.828843423222;9637.22902167839;10505.68482945513;10532.94229914101;10601.098906593026;10632.362058276529 05:13:27 INFO - PROCESS | 24381 | |3;mootools.html;1298.6169080121374;1380.8757211850932;1383.2184815579194;1489.5754709907678;1719.922603482844;7365.189829118799;7729.690812367506;7980.680772769082;8054.43618946674;8240.91759082409;7998.440109192359;8090.838183236332;8121.269085782278;8129.6748130074875;8130.065042520112;1931.642646110474;2107.272990818169;2140.636091864379;2153.7092492513543;2155.0948601587293;1987.0958713785265;2176.62997290461;2241.529278851443;2244.1584405847807;2255.76314486979;2173.1416090644266;2174.3150907464096;2189.9890500547476;2191.2111639809655;2200.9559808803815;2158.4927542027613;2179.3788770200417;2182;2182.2471247419617;2184.486645638274;2142.4322554523064;2190.9342719718434;2195.868247905131;2197.6703494475796;2204.7244094488187;8188.426810123294;8403.663853445854;8414.242718155334;8417.70538031166;8436.240738333518;5073.974630126862;5163.457836927106;5233.659812112201;5233.764480598382;5240;3190.6649801770714;3322.285708572644;3472.6700963408434;3478.113081164287;3495.825208739578;1017.8218811707995;1082.506141524691;1105.7733164701217;1110.4392281897672;1129.2603344809163;11738.941305293505;11752;11755.05959523236;11755.294682319003;11773.764524709544;4457.0834541147615;4547.636189104864;4625.306204069349;4648.5119062498625;4649.395578574764;9144.085591440802;9198;9206.63173473067;9207.677731279373;9218.124278193562;5042.697438153723;5076.238564215398;5129.358830146231;5134.152864777345;5137.743112844343;4288.52826189119;4443.488998765119;4695.765211739399;4782;4800.615950724004;3549.716022718176;3625.1118475973026;3685.852565897334;3714.665680088805;3727.1241258304276;1102.6581759654373;1106.8616422947132;1131.8189089745765;1133.7562424078862;1139.800534906388;831.1807245705971;837.995810020946;888.4225253585092;906.4923642760075;930.4556834252038;5482.396936337;5651.463111004448;5662.518685911661;5722.084466485342;5728.684922329228;898.4429653614801;902.0348227396754;917.8247553298725;923.3997901364168;927.1053433436766;3787.9431808522895;3870.9419358709642;3887.8056097195026;3903.765774053566;3910.1202229498704;10138.645147419953;10597.788044239072;10605.204609654307;10615.787684246427;10619.09737672291;10447.111995480318;10450.738731531772;10497.580096796042;10503.264771466076;10511.26421150512;7402.518836275625;7857.214278572097;8010.399220058519;8016.79958001043;8022.839543209103;5570.749316280696;5647.15292706081;5673.744681489426;5720.599558030898;5848.94151058501;9323.813523729352;9387.389819661701;9418.387804792666;9499.525023748924;9518.333716639769;8998.190162885372;9051.773705657411;9133.862992055258;9207.76980575491;9426.905730942603;6600.60396376219;6769.966150169218;7181.892271615826;7567.281108294703;7584.734534291273;7683.308502234826;7913.723019694283;7955.4828936118965;8140.959295203486;8166.6733330668485;7216.170140433917;7325.120985481776;7375.151857536452;7459.552426854406;7602.619869006417;7044.189918159477;7233.855322893618;7264.818379540554;7404.222556631476;7493.962530187532;6597.736090556516;6653.833654158685;6675.332466753286;6677.966610166918;6683.933160668331;4778.641601879943;4802.303665968485;5055.064813009458;5087.211482220262;5121.257417674342;4910.803567857246;4972.508008102828;5031.798728050837;5072.239164125411;5116.130257856248 05:13:27 INFO - PROCESS | 24381 | |4;prototype.html;361.7413549312241;380.1446744824146;384.3619591478145;385.95175603049637;387.7150294533516;5079.56823669988;5144.8971020579565;5161.819336323234;5170.327857378536;5203.8143979528595;5009.171652346895;5131.461196574362;5152.093725321627;5153.144867847581;5169.870753231171;4101.405296232045;4118.670506359484;4142.316517774579;4149.3775933609895;4156.480439945007;4109.6506796922295;4117.114820313632;4119.526254480728;4126.628603425691;4129.339305711087;4043.65628921542;4046.372812214097;4069.9796501017454;4142.8135733891895;4147.253494371012;3973.6622387096986;4046.473958385391;4052.1693052924375;4055.270051390734;4061.8578349757618;3678.889633311005;3683.4658974448553;3699.85200591976;3703.814809259526;3704.1665625234377;4945.7774400152075;4966.55301022906;4980.402351717781;4980.576650984671;4990.775415106329;4361.520232774392;4584.885377865547;4594.563516465931;4676.906461870778;4678.830292426894;5345.7594408251725;5368.289014047881;5378.946210537883;5388;5395;3897;3922.7646341219333;3936.563154448634;3943.3493473576827;3952.9011774705864;5293.364796224478;5445.292112025451;5480.506754392084;5498.065328894098;5517.613767036309;3956.408552398126;3959.4456776051375;3977.7613343198923;3979.900502487461;3991;4014.6788256939376;4016.9397459038137;4033.3949907514107;4048.2105989332385;4061.7156799023783;4443.4445694288215;4596.35651008859;4628.629709623289;4644.58198762113;4664.207084795593;5376.91934620981;5400.6498375406145;5408.91886621701;5435.456454354533;5443.646162999472;1359.9048066635241;1362.8364596248316;1363.5159518370835;1370.8492065872945;1375.559820857316;893.4148132972913;932.9346945713735;933.3093510801957;938.5635679409107;945.7682867697458;5037.420696619863;5038.571721403721;5052.898942021139;5058.924116138187;5083.593312534988;5293.867653308621;5316.644255714768;5366.946330536723;5386.114859799039;5395.3525576931015;4981.576565991859;5086.4659210783075;5093.5228783653065;5101.7194054327365;5274.446183150714;2858.799884008141;2870.167651381076;2877.6690680571583;2881.6686081100943;2883.1494709060876;5554.250176226158;5589.105743081088;5594.804181853616;5608.495235428831;5621.690807005572;5403;5404.594655400861;5507.925954438926;5664.065429204217;5703.74333155009;5605.691686957257;5633.718314084362;5686.857828554319;5689.6586204827845;5705.85882823437;5534.4742249486235;5565.55475561946;5565.777368905198;5583.581231407579;5594.776208951596;5261.23748544242;5524.171374293888;5548.278723766046;5564.386327965007;5581.465097098168;5686.573506987075;5695.601307908407;5717.714114294352;5725.656460612377;5735.885282294247;3988.980055099706;4014.759114453142;4018.598140186075;4038.4346191532622;4060.939085913773;5428.402875683751;5498.80754173602;5538;5539.7784088636;5664.892952609325;5416.8104116355735;5417.485338892799;5419.292922729328;5423.891522169613;5445.863853403696;5333.973330133324;5420.945790542044;5441.972790136024;5453.672779633234;5499.725013749377;5334.626576139633;5346.759395827275;5355.812546560852;5363.946360536501;5407.161889907071;5387.676739395649;5449;5455.563554915518;5465;5477.274658482565;5160.148575485003;5334.466553344634;5375;5378.19327100938;5444.673319600836 05:13:27 INFO - PROCESS | 24381 | |5;yui.html;657.4641667041363;675.959442433454;691.0739608924044;724.3878922310649;778.2762031310882;13908;14021.929890350546;14105.92947035266;14568.854311456882;14669.92665036676;12273.631791046282;13427.127236729606;13559.050866439353;13590.25253611051;13608.387622556984;651.7555916531301;683.0471492268283;792.1247022040662;802.257911431926;809.2837838512929;746.3096635612064;789.8143936174994;796.928276455119;800.0359566722115;804.8470790549806;846.8306338732248;848.2196379331;849.5072857742495;849.9065102838683;849.9830003399928;689.2521614048763;719.3741444942907;722.2055738687454;724.851405461879;847.3094428041157;589.7906243283616;612.5130521235628;612.8161551534522;615.0681717198448;615.8398816307747;12700.936495317465;12725.754932492247;12752.936235318764;12755.043371747157;12755.362231888368;13816.792748108786;13882.305884705724;13889.722205555934;13937.930310348485;14071.366788494543;11485.0811935045;11633.76732465346;11768.411579420994;11889.167758256925;12168.634940951786;4242.575742425764;4374;4427.2695005324085;4456.598906098434;4473.485549161823;64787.493063090165;71228.64385678091;72362;72757;73391.26608733898;10338.844917326247;10509.789804203872;10616.150707943347;10618.575256989789;10822.945885270523;20788.064537095866;20790.688139677917;20866.47833804167;21079.26222582233;21381;7886.881696774438;8163.7142700005215;8240.299574536231;8257.463264887883;8694.043655197924;4366.890827729332;4401.6478681705385;4533.52397998212;4639.30410438437;4668.533146685372;3214.9357012860078;3322.5016247562576;3325.1687078230443;3325.8004519728893;3327.03515980363;589.0927970924813;590.2769107842859;600.6996501749126;602.3735315272155;612.0941007309208;555.4667519181551;637.9187277564483;666.73997141115;698.4552049401475;718.4252597921642;8137.389695772841;8613.612387442456;8662.2637075848;8945.418547794372;9122.635094596142;584.6579750845802;586.8092869817326;596.5704692621306;614.0390289197392;720.9819754506075;3992.700547458894;4346.21768081742;4352.934705979413;4380.233459144637;4386.210482113186;78565.21434785693;80516;81261;81600.59199703964;82724.58637706772;68512.65743671349;70770.64614676894;70905.64547177334;72983.2701672987;73386;62775;63184.684076579324;63505.364946349946;63861.36138638554;64272.357276426636;8189.181081892001;8300.792480187802;8324.822518370906;8388.832223355621;8455.112213217524;38686.613133868304;41201.283448117596;42402.363964541175;43015.784921075196;44851.32723009092;43650.34524482072;44625;52430.47569524256;52733;54379;12203.755924881276;12868.613941581767;12890.548830790878;12897.935510322388;13285.66785830362;14124.152550846982;14267.07264027835;14449;14651.560453186421;14747.483838065617;13333.599992000256;13431.462741490232;13804.447822087004;13952.099682024515;14086.718265634834;11613.883861161617;11867.821982670439;11994.500121612682;12136;12330.260184388966;12550.937245313715;12800.871991279968;13400.195988240737;13499.257540835348;14397.064190827563;10679.305845120043;10960.213945288622;11352.772944541228;11544.538218471167;11817.940910295394;10434.69566304212;10693.786124277627;11016.50425730828;11188.66434006981;11225.887741122811 05:13:27 INFO - PROCESS | 24381 | __end_tp_report 05:13:27 INFO - PROCESS | 24381 | __start_cc_report 05:13:27 INFO - PROCESS | 24381 | _x_x_mozilla_cycle_collect,2411 05:13:27 INFO - PROCESS | 24381 | __end_cc_report 05:13:27 INFO - PROCESS | 24381 | __startTimestamp1481807607914__endTimestamp 05:13:27 INFO - PROCESS | 24381 | 05:13:27 INFO - PROCESS | 24381 | ------- Summary: start ------- 05:13:27 INFO - PROCESS | 24381 | Number of tests: 6 05:13:27 INFO - PROCESS | 24381 | 05:13:27 INFO - PROCESS | 24381 | [#0] dojo.html Cycles:165 Average:5312.62 Median:5491.53 stddev:591.19 (10.8%) stddev-sans-first:566.10 05:13:27 INFO - PROCESS | 24381 | Values: 3065.2 3089.6 3103.8 3107.0 3112.2 5134.6 5188.9 5350.5 5367.5 5434.1 5248.8 5355.3 5427.8 5429.8 5473.7 4842.2 4868.2 4905.6 4907.4 4945.6 4890.6 4973.3 4995.1 5004.2 5047.4 4959.7 4976.7 4993.9 5041.4 5064.4 4774.8 4809.8 4814.4 4855.4 4874.9 4826.0 4829.3 4837.3 4840.4 4847.7 5263.5 5327.1 5330.3 5334.4 5343.3 5675.7 5688.5 5688.6 5689.3 5700.1 5705.7 5721.5 5727.5 5729.8 5731.8 5309.2 5337.2 5346.5 5351.4 5356.9 5729.3 5729.9 5748.2 5766.3 5813.7 5589.1 5590.8 5592.7 5597.7 5604.3 5501.7 5543.1 5543.8 5671.0 5677.2 5655.7 5700.1 5708.7 5748.5 5779.5 5778.8 5778.9 5788.7 5789.4 5825.0 4285.6 4443.6 4443.6 4445.3 4488.7 3865.0 3897.5 3904.4 3914.9 3928.4 5436.2 5449.9 5487.0 5493.2 5493.7 5699.6 5704.9 5722.2 5722.8 5746.7 5233.8 5251.7 5412.0 5421.3 5459.1 4907.4 4951.3 4967.1 4979.4 5036.1 5875.8 5913.7 5924.0 5927.3 5930.5 5562.6 5737.7 5743.0 5744.1 5747.1 5705.6 5905.1 5906.0 5914.2 6028.5 5711.7 5722.4 5723.9 5731.2 5731.8 5700.9 5795.0 5798.9 5807.6 5824.0 5447.3 5494.3 5494.7 5561.8 5575.8 5504.2 5542.4 5548.1 5552.9 5553.6 5468.7 5475.7 5480.8 5482.5 5483.3 5577.1 5581.6 5595.1 5595.1 5596.6 5479.1 5485.4 5490.9 5491.5 5493.7 05:13:27 INFO - PROCESS | 24381 | 05:13:27 INFO - PROCESS | 24381 | [#1] ext.html Cycles:180 Average:57258.40 Median:36745.63 stddev:110068.20 (299.5%) stddev-sans-first:110294.65 05:13:27 INFO - PROCESS | 24381 | Values: 561.9 578.5 579.5 584.7 596.1 40208.4 41653.4 41936.2 45626.8 45629.0 43571.8 44055.6 44063.3 44097.0 44250.6 7904.4 8117.8 8580.7 8735.4 8747.4 9967.9 10263.3 10271.2 10576.1 10577.4 10374.5 10440.9 10454.8 10455.5 10458.0 10211.5 10269.3 10271.9 10281.9 10286.3 10139.4 10192.0 10208.1 10209.6 10216.8 40426.2 40758.2 40808.4 40820.0 40828.6 3476.3 3518.5 3587.8 3779.5 3813.8 30037.8 30128.1 30335.2 30337.8 30866.2 4031.7 4129.2 4133.2 4145.8 4180.0 322084.0 322448.0 322778.0 323642.0 323908.0 51488.5 51830.2 52244.7 52321.7 58883.7 54993.0 55063.4 55192.0 55207.4 55270.4 14997.3 15328.8 15342.8 15350.1 15355.4 11107.7 11319.9 11723.5 11970.0 12290.1 17580.6 17884.6 17986.2 17999.3 18109.7 5746.2 5773.1 5773.4 5845.8 5927.4 889.8 1066.4 1071.9 1078.8 1104.3 30752.7 30881.0 31166.8 31466.5 31675.2 1029.5 1062.0 1077.9 1106.9 1124.6 15595.0 16269.4 16330.2 16512.5 16635.3 449868.0 450381.0 451878.0 452051.0 452718.0 57392.1 57651.4 57659.7 57705.4 57721.4 1202.2 1242.6 1242.7 1328.6 1336.8 30174.0 34125.3 34364.3 34462.1 34474.3 55522.0 55964.2 56011.0 56296.4 56353.7 457142.0 458787.0 460686.0 461064.0 464339.0 34635.3 35040.0 35917.0 36037.1 41181.0 43761.6 44072.6 44386.8 45478.8 45549.5 36767.6 36970.4 37671.0 37687.2 39048.4 36723.6 37225.9 37355.0 37597.2 38008.6 37495.8 37631.6 38193.6 38251.4 38268.8 30042.8 33612.3 33883.7 33978.2 33990.3 25533.4 25787.7 26148.7 26151.0 26272.6 05:13:27 INFO - PROCESS | 24381 | 05:13:27 INFO - PROCESS | 24381 | [#2] jquery.html Cycles:180 Average:25997.07 Median:20465.08 stddev:68666.18 (335.5%) stddev-sans-first:68831.87 05:13:27 INFO - PROCESS | 24381 | Values: 381.2 386.2 386.8 392.7 415.2 14312.5 15016.3 17311.0 18715.9 18747.7 16982.9 17097.0 17123.7 17363.2 18106.9 5487.0 5510.5 5691.8 5733.4 5742.4 5556.2 5675.6 5683.9 5685.7 5686.7 5408.4 5519.2 5607.7 5653.6 5655.4 5570.5 5613.2 5622.1 5623.2 5623.4 4844.0 5017.1 5030.3 5043.4 5049.7 18184.0 18274.4 18942.8 21360.1 21667.0 2145.9 2410.4 2423.9 2488.9 2888.6 9571.7 9699.4 9942.2 9950.0 10202.2 1857.8 1958.4 1971.2 1975.3 1985.9 72578.0 74033.6 76723.0 78343.0 78684.2 10562.0 10627.7 10652.9 10948.5 10987.8 13199.3 14686.4 14798.9 14801.1 14825.5 6958.4 7434.9 7741.6 7751.9 7853.3 7086.1 7217.8 7226.7 7349.3 7377.4 4507.0 4560.8 4561.4 4566.5 4681.6 1889.8 1908.2 1930.9 1946.8 1973.3 812.4 939.3 974.5 980.1 1011.3 17614.4 18395.6 18917.8 19047.4 19194.0 968.6 974.4 998.1 1001.4 1008.7 8025.7 9827.4 10091.3 10701.7 10844.5 311810.0 428438.0 432445.0 435901.0 443559.0 91555.0 92998.5 94281.5 94544.5 94950.5 948.2 988.9 993.9 994.6 1006.0 15147.9 16294.6 16971.5 17141.7 17188.6 37703.0 38946.4 39564.0 40515.0 41655.4 53428.2 53519.5 53621.5 54112.7 55087.4 7747.9 8102.0 8125.0 8410.1 8448.4 11306.9 11886.4 12251.9 12291.8 12760.4 10307.9 10527.3 10560.4 10919.0 11158.8 10727.2 10768.9 10902.7 10922.4 11290.9 10794.6 10813.3 10875.7 11056.5 11477.9 8022.1 8217.2 8236.9 8504.6 8557.8 9637.2 10505.7 10532.9 10601.1 10632.4 05:13:27 INFO - PROCESS | 24381 | 05:13:27 INFO - PROCESS | 24381 | [#3] mootools.html Cycles:180 Average:5478.37 Median:5101.67 stddev:3087.42 (60.5%) stddev-sans-first:3080.10 05:13:27 INFO - PROCESS | 24381 | Values: 1298.6 1380.9 1383.2 1489.6 1719.9 7365.2 7729.7 7980.7 8054.4 8240.9 7998.4 8090.8 8121.3 8129.7 8130.1 1931.6 2107.3 2140.6 2153.7 2155.1 1987.1 2176.6 2241.5 2244.2 2255.8 2173.1 2174.3 2190.0 2191.2 2201.0 2158.5 2179.4 2182.0 2182.2 2184.5 2142.4 2190.9 2195.9 2197.7 2204.7 8188.4 8403.7 8414.2 8417.7 8436.2 5074.0 5163.5 5233.7 5233.8 5240.0 3190.7 3322.3 3472.7 3478.1 3495.8 1017.8 1082.5 1105.8 1110.4 1129.3 11738.9 11752.0 11755.1 11755.3 11773.8 4457.1 4547.6 4625.3 4648.5 4649.4 9144.1 9198.0 9206.6 9207.7 9218.1 5042.7 5076.2 5129.4 5134.2 5137.7 4288.5 4443.5 4695.8 4782.0 4800.6 3549.7 3625.1 3685.9 3714.7 3727.1 1102.7 1106.9 1131.8 1133.8 1139.8 831.2 838.0 888.4 906.5 930.5 5482.4 5651.5 5662.5 5722.1 5728.7 898.4 902.0 917.8 923.4 927.1 3787.9 3870.9 3887.8 3903.8 3910.1 10138.6 10597.8 10605.2 10615.8 10619.1 10447.1 10450.7 10497.6 10503.3 10511.3 7402.5 7857.2 8010.4 8016.8 8022.8 5570.7 5647.2 5673.7 5720.6 5848.9 9323.8 9387.4 9418.4 9499.5 9518.3 8998.2 9051.8 9133.9 9207.8 9426.9 6600.6 6770.0 7181.9 7567.3 7584.7 7683.3 7913.7 7955.5 8141.0 8166.7 7216.2 7325.1 7375.2 7459.6 7602.6 7044.2 7233.9 7264.8 7404.2 7494.0 6597.7 6653.8 6675.3 6678.0 6683.9 4778.6 4802.3 5055.1 5087.2 5121.3 4910.8 4972.5 5031.8 5072.2 5116.1 05:13:27 INFO - PROCESS | 24381 | 05:13:27 INFO - PROCESS | 24381 | [#4] prototype.html Cycles:180 Average:4551.88 Median:5160.98 stddev:1314.52 (25.5%) stddev-sans-first:1280.03 05:13:27 INFO - PROCESS | 24381 | Values: 361.7 380.1 384.4 386.0 387.7 5079.6 5144.9 5161.8 5170.3 5203.8 5009.2 5131.5 5152.1 5153.1 5169.9 4101.4 4118.7 4142.3 4149.4 4156.5 4109.7 4117.1 4119.5 4126.6 4129.3 4043.7 4046.4 4070.0 4142.8 4147.3 3973.7 4046.5 4052.2 4055.3 4061.9 3678.9 3683.5 3699.9 3703.8 3704.2 4945.8 4966.6 4980.4 4980.6 4990.8 4361.5 4584.9 4594.6 4676.9 4678.8 5345.8 5368.3 5378.9 5388.0 5395.0 3897.0 3922.8 3936.6 3943.3 3952.9 5293.4 5445.3 5480.5 5498.1 5517.6 3956.4 3959.4 3977.8 3979.9 3991.0 4014.7 4016.9 4033.4 4048.2 4061.7 4443.4 4596.4 4628.6 4644.6 4664.2 5376.9 5400.6 5408.9 5435.5 5443.6 1359.9 1362.8 1363.5 1370.8 1375.6 893.4 932.9 933.3 938.6 945.8 5037.4 5038.6 5052.9 5058.9 5083.6 5293.9 5316.6 5366.9 5386.1 5395.4 4981.6 5086.5 5093.5 5101.7 5274.4 2858.8 2870.2 2877.7 2881.7 2883.1 5554.3 5589.1 5594.8 5608.5 5621.7 5403.0 5404.6 5507.9 5664.1 5703.7 5605.7 5633.7 5686.9 5689.7 5705.9 5534.5 5565.6 5565.8 5583.6 5594.8 5261.2 5524.2 5548.3 5564.4 5581.5 5686.6 5695.6 5717.7 5725.7 5735.9 3989.0 4014.8 4018.6 4038.4 4060.9 5428.4 5498.8 5538.0 5539.8 5664.9 5416.8 5417.5 5419.3 5423.9 5445.9 5334.0 5420.9 5442.0 5453.7 5499.7 5334.6 5346.8 5355.8 5363.9 5407.2 5387.7 5449.0 5455.6 5465.0 5477.3 5160.1 5334.5 5375.0 5378.2 5444.7 05:13:27 INFO - PROCESS | 24381 | 05:13:27 INFO - PROCESS | 24381 | [#5] yui.html Cycles:180 Average:17011.75 Median:24540.80 stddev:22037.75 (89.8%) stddev-sans-first:22065.35 05:13:27 INFO - PROCESS | 24381 | Values: 657.5 676.0 691.1 724.4 778.3 13908.0 14021.9 14105.9 14568.9 14669.9 12273.6 13427.1 13559.1 13590.3 13608.4 651.8 683.0 792.1 802.3 809.3 746.3 789.8 796.9 800.0 804.8 846.8 848.2 849.5 849.9 850.0 689.3 719.4 722.2 724.9 847.3 589.8 612.5 612.8 615.1 615.8 12700.9 12725.8 12752.9 12755.0 12755.4 13816.8 13882.3 13889.7 13937.9 14071.4 11485.1 11633.8 11768.4 11889.2 12168.6 4242.6 4374.0 4427.3 4456.6 4473.5 64787.5 71228.6 72362.0 72757.0 73391.3 10338.8 10509.8 10616.2 10618.6 10822.9 20788.1 20790.7 20866.5 21079.3 21381.0 7886.9 8163.7 8240.3 8257.5 8694.0 4366.9 4401.6 4533.5 4639.3 4668.5 3214.9 3322.5 3325.2 3325.8 3327.0 589.1 590.3 600.7 602.4 612.1 555.5 637.9 666.7 698.5 718.4 8137.4 8613.6 8662.3 8945.4 9122.6 584.7 586.8 596.6 614.0 721.0 3992.7 4346.2 4352.9 4380.2 4386.2 78565.2 80516.0 81261.0 81600.6 82724.6 68512.7 70770.6 70905.6 72983.3 73386.0 62775.0 63184.7 63505.4 63861.4 64272.4 8189.2 8300.8 8324.8 8388.8 8455.1 38686.6 41201.3 42402.4 43015.8 44851.3 43650.3 44625.0 52430.5 52733.0 54379.0 12203.8 12868.6 12890.5 12897.9 13285.7 14124.2 14267.1 14449.0 14651.6 14747.5 13333.6 13431.5 13804.4 13952.1 14086.7 11613.9 11867.8 11994.5 12136.0 12330.3 12550.9 12800.9 13400.2 13499.3 14397.1 10679.3 10960.2 11352.8 11544.5 11817.9 10434.7 10693.8 11016.5 11188.7 11225.9 05:13:27 INFO - PROCESS | 24381 | -------- Summary: end -------- 05:13:27 INFO - PROCESS | 24381 | 05:13:28 INFO - TEST-INFO | 24381: exit 0 05:13:28 INFO - TEST-OK | dromaeo_css | took 1117705ms 05:13:28 INFO - TEST-START | kraken 05:13:28 INFO - operating with platform_type : linux_ 05:13:28 INFO - Initialising browser for kraken test... 05:13:28 INFO - TEST-INFO | started process 24684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMjyXtK/profile http://localhost:52379/getInfo.html) 05:13:32 INFO - PROCESS | 24684 | __metrics Screen width/height:1600/1200 05:13:32 INFO - PROCESS | 24684 | colorDepth:24 05:13:32 INFO - PROCESS | 24684 | Browser inner width/height: 1024/697 05:13:32 INFO - PROCESS | 24684 | __metrics 05:13:33 INFO - PROCESS | 24684 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:13:33 INFO - PROCESS | 24684 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:13:34 INFO - PROCESS | 24684 | console.error: PushService: 05:13:34 INFO - PROCESS | 24684 | stateChangeProcessEnqueue: Error transitioning state 05:13:34 INFO - PROCESS | 24684 | UnknownError 05:13:34 INFO - TEST-INFO | 24684: exit 0 05:13:34 INFO - Browser initialized. 05:13:34 INFO - Running cycle 1/1 for kraken test... 05:13:34 INFO - TEST-INFO | started process 24768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMjyXtK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:46 INFO - PROCESS | 24768 | RSS: Main: 172900352 05:13:46 INFO - PROCESS | 24768 | 05:13:49 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52379/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:50 INFO - PROCESS | 24768 | RSS: Main: 234663936 05:13:50 INFO - PROCESS | 24768 | 05:13:52 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52379/tests/kraken/driver.html?testName=audio-dft) 05:13:53 INFO - PROCESS | 24768 | RSS: Main: 217092096 05:13:53 INFO - PROCESS | 24768 | 05:13:56 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52379/tests/kraken/driver.html?testName=audio-fft) 05:13:57 INFO - PROCESS | 24768 | RSS: Main: 298897408 05:13:57 INFO - PROCESS | 24768 | 05:13:59 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52379/tests/kraken/driver.html?testName=audio-oscillator) 05:13:59 INFO - PROCESS | 24768 | RSS: Main: 209682432 05:13:59 INFO - PROCESS | 24768 | 05:14:02 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:02 INFO - PROCESS | 24768 | RSS: Main: 213905408 05:14:02 INFO - PROCESS | 24768 | 05:14:05 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52379/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:06 INFO - PROCESS | 24768 | RSS: Main: 253456384 05:14:06 INFO - PROCESS | 24768 | 05:14:09 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52379/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:10 INFO - PROCESS | 24768 | RSS: Main: 252964864 05:14:10 INFO - PROCESS | 24768 | 05:14:13 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52379/tests/kraken/driver.html?testName=json-parse-financial) 05:14:13 INFO - PROCESS | 24768 | RSS: Main: 251654144 05:14:13 INFO - PROCESS | 24768 | 05:14:15 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:15 INFO - PROCESS | 24768 | RSS: Main: 213729280 05:14:15 INFO - PROCESS | 24768 | 05:14:17 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:18 INFO - PROCESS | 24768 | RSS: Main: 222027776 05:14:18 INFO - PROCESS | 24768 | 05:14:20 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:20 INFO - PROCESS | 24768 | RSS: Main: 230404096 05:14:20 INFO - PROCESS | 24768 | 05:14:23 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:24 INFO - PROCESS | 24768 | RSS: Main: 239087616 05:14:24 INFO - PROCESS | 24768 | 05:14:27 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:27 INFO - PROCESS | 24768 | RSS: Main: 235827200 05:14:27 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52379/tests/kraken/driver.html?testName=ai-astar) 05:14:29 INFO - PROCESS | 24768 | RSS: Main: 288403456 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | __start_tp_report 05:14:29 INFO - PROCESS | 24768 | _x_x_mozilla_page_load 05:14:29 INFO - PROCESS | 24768 | _x_x_mozilla_page_load_details 05:14:29 INFO - PROCESS | 24768 | |i|pagename|runs| 05:14:29 INFO - PROCESS | 24768 | |0;ai-astar;113;115;114;113;116;113;113;114;115;112 05:14:29 INFO - PROCESS | 24768 | |1;audio-beat-detection;146;123;124;161;128;124;122;124;145;124 05:14:29 INFO - PROCESS | 24768 | |2;audio-dft;161;161;161;161;161;160;161;161;162;161 05:14:29 INFO - PROCESS | 24768 | |3;audio-fft;76;78;75;107;77;77;77;75;107;75 05:14:29 INFO - PROCESS | 24768 | |4;audio-oscillator;85;84;114;85;86;85;102;84;85;110 05:14:29 INFO - PROCESS | 24768 | |5;imaging-gaussian-blur;126;127;127;127;127;127;127;127;126;127 05:14:29 INFO - PROCESS | 24768 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;145;146 05:14:29 INFO - PROCESS | 24768 | |7;imaging-desaturate;94;95;96;95;95;95;95;96;96;96 05:14:29 INFO - PROCESS | 24768 | |8;json-parse-financial;53;52;55;52;53;54;52;54;52;52 05:14:29 INFO - PROCESS | 24768 | |9;json-stringify-tinderbox;63;64;64;63;64;64;63;63;65;64 05:14:29 INFO - PROCESS | 24768 | |10;stanford-crypto-aes;81;80;80;80;80;81;81;81;81;80 05:14:29 INFO - PROCESS | 24768 | |11;stanford-crypto-ccm;143;142;148;131;140;134;132;135;189;136 05:14:29 INFO - PROCESS | 24768 | |12;stanford-crypto-pbkdf2;171;171;169;176;177;166;170;166;168;167 05:14:29 INFO - PROCESS | 24768 | |13;stanford-crypto-sha256-iterative;66;65;74;64;65;64;64;63;63;63 05:14:29 INFO - PROCESS | 24768 | __end_tp_report 05:14:29 INFO - PROCESS | 24768 | __start_cc_report 05:14:29 INFO - PROCESS | 24768 | _x_x_mozilla_cycle_collect,1662 05:14:29 INFO - PROCESS | 24768 | __end_cc_report 05:14:29 INFO - PROCESS | 24768 | __startTimestamp1481807669635__endTimestamp 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | ------- Summary: start ------- 05:14:29 INFO - PROCESS | 24768 | Number of tests: 14 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:1.23 (1.1%) stddev-sans-first:1.27 05:14:29 INFO - PROCESS | 24768 | Values: 113.0 115.0 114.0 113.0 116.0 113.0 113.0 114.0 115.0 112.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:126.00 stddev:13.58 (10.8%) stddev-sans-first:13.44 05:14:29 INFO - PROCESS | 24768 | Values: 146.0 123.0 124.0 161.0 128.0 124.0 122.0 124.0 145.0 124.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 05:14:29 INFO - PROCESS | 24768 | Values: 161.0 161.0 161.0 161.0 161.0 160.0 161.0 161.0 162.0 161.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:13.01 (17.0%) stddev-sans-first:13.59 05:14:29 INFO - PROCESS | 24768 | Values: 76.0 78.0 75.0 107.0 77.0 77.0 77.0 75.0 107.0 75.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:85.00 stddev:11.87 (14.0%) stddev-sans-first:12.32 05:14:29 INFO - PROCESS | 24768 | Values: 85.0 84.0 114.0 85.0 86.0 85.0 102.0 84.0 85.0 110.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#5] imaging-gaussian-blur Cycles:10 Average:126.80 Median:127.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 05:14:29 INFO - PROCESS | 24768 | Values: 126.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 126.0 127.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:14:29 INFO - PROCESS | 24768 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 05:14:29 INFO - PROCESS | 24768 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.10 (2.1%) stddev-sans-first:1.17 05:14:29 INFO - PROCESS | 24768 | Values: 53.0 52.0 55.0 52.0 53.0 54.0 52.0 54.0 52.0 52.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 05:14:29 INFO - PROCESS | 24768 | Values: 63.0 64.0 64.0 63.0 64.0 64.0 63.0 63.0 65.0 64.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 05:14:29 INFO - PROCESS | 24768 | Values: 81.0 80.0 80.0 80.0 80.0 81.0 81.0 81.0 81.0 80.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:141.00 stddev:17.03 (12.1%) stddev-sans-first:18.06 05:14:29 INFO - PROCESS | 24768 | Values: 143.0 142.0 148.0 131.0 140.0 134.0 132.0 135.0 189.0 136.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:170.50 stddev:3.84 (2.3%) stddev-sans-first:4.06 05:14:29 INFO - PROCESS | 24768 | Values: 171.0 171.0 169.0 176.0 177.0 166.0 170.0 166.0 168.0 167.0 05:14:29 INFO - PROCESS | 24768 | 05:14:29 INFO - PROCESS | 24768 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:64.50 stddev:3.28 (5.1%) stddev-sans-first:3.46 05:14:29 INFO - PROCESS | 24768 | Values: 66.0 65.0 74.0 64.0 65.0 64.0 64.0 63.0 63.0 63.0 05:14:29 INFO - PROCESS | 24768 | -------- Summary: end -------- 05:14:29 INFO - PROCESS | 24768 | 05:14:30 INFO - TEST-INFO | 24768: exit 0 05:14:30 INFO - TEST-OK | kraken | took 62051ms 05:14:30 INFO - SUITE-END | took 1179s 05:14:31 INFO - Completed test suite (00:19:40) 05:14:31 INFO - javascript benchmark 05:14:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.203047207726, 3089.5674605555214, 3103.813771173728, 3106.9689303106975, 3112.1752735525083, 5134.589232861372, 5188.8702782430455, 5350.5184533391985, 5367.543758780504, 5434.1305391137375, 5248.763805628746, 5355.3305836770405, 5427.83716488506, 5429.782808687658, 5473.67157970522, 4842.176829938919, 4868.221084626461, 4905.607551395879, 4907.362042934414, 4945.579625731799, 4890.633202509808, 4973.254011898208, 4995.0509403213455, 5004.199328107504, 5047.369078865142, 4959.727215003173, 4976.726280054596, 4993.875153121183, 5041.395032596093, 5064.417591976915, 4774.761261936924, 4809.783559739785, 4814.422269327668, 4855.393075865517, 4874.878128046792, 4826.0, 4829.251466022737, 4837.298591704219, 4840.443349014873, 4847.660663753539, 5263.499967503081, 5327.147656374961, 5330.28041214435, 5334.3598768147685, 5343.305370301875, 5675.744591493392, 5688.544916406678, 5688.5733569982, 5689.345725241609, 5700.144978253254, 5705.74324155414, 5721.542276617861, 5727.513161381287, 5729.799457018984, 5731.828045158652, 5309.177077552986, 5337.172738225542, 5346.465353464661, 5351.384590772033, 5356.91964620531, 5729.28383952006, 5729.88540229193, 5748.223989761413, 5766.308043034863, 5813.7383817728305, 5589.105743081088, 5590.832275031756, 5592.748326325243, 5597.720113994284, 5604.299462567179, 5501.697406642673, 5543.085390910454, 5543.805966791143, 5671.0, 5677.205191273225, 5655.660660360391, 5700.116481945305, 5708.686022268732, 5748.511376533042, 5779.49733069405, 5778.797742079007, 5778.884422311614, 5788.652680839079, 5789.421057894177, 5824.970875145682, 4285.5928686774705, 4443.555644435595, 4443.577860103285, 4445.310976798602, 4488.730676159375, 3864.9806750966063, 3897.493325867619, 3904.4338570907057, 3914.8629797957506, 3928.4107383892647, 5436.157395603609, 5449.945500545023, 5487.012337779158, 5493.176023596413, 5493.670379777146, 5699.5725320600295, 5704.857378565569, 5722.227499287626, 5722.828315150552, 5746.655200687972, 5233.842984710464, 5251.684898906002, 5412.0, 5421.295231619864, 5459.071957767189, 4907.411110666742, 4951.306817045616, 4967.105920934194, 4979.427365852901, 5036.06832735945, 5875.794347197828, 5913.674747888907, 5924.0, 5927.31835838884, 5930.525557955353, 5562.582806289463, 5737.713114344349, 5742.971285143548, 5744.0522313817755, 5747.1379293106365, 5705.572082093777, 5905.143754155538, 5905.9959806832085, 5914.2311499504785, 6028.5177185825905, 5711.742971566373, 5722.4277572242445, 5723.914141287967, 5731.197632331394, 5731.799387021601, 5700.857478563069, 5795.043817770021, 5798.85502862415, 5807.593468457168, 5824.039033559416, 5447.346318441812, 5494.2857428534035, 5494.670319780826, 5561.777528898961, 5575.776968921197, 5504.22940788298, 5542.418046105101, 5548.112302031655, 5552.917181149637, 5553.555715542666, 5468.72656367188, 5475.698836564027, 5480.808171713971, 5482.506574408322, 5483.287172667528, 5577.051901176728, 5581.609287349846, 5595.104783234826, 5595.132754423071, 5596.552275817843, 5479.123340265538, 5485.396606373375, 5490.917636235539, 5491.533219676372, 5493.6978466183145], "value": 5273.2408370305175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.8820047789964, 578.459140703442, 579.5132089045204, 584.7427132061893, 596.1147695671929, 40208.39687404688, 41653.375199372036, 41936.161276774445, 45626.771866140705, 45629.0, 43571.78214108933, 44055.559444405546, 44063.33904991428, 44097.0, 44250.55749442505, 7904.446688731791, 8117.756467305991, 8580.742577722678, 8735.388522803407, 8747.431416957908, 9967.850482242737, 10263.281570290083, 10271.229657775659, 10576.10103141234, 10577.36535807854, 10374.533146008447, 10440.947795261012, 10454.790904181911, 10455.4772261387, 10458.0, 10211.540480678388, 10269.332493387943, 10271.948640256825, 10281.948590257076, 10286.331388459726, 10139.391636501834, 10192.0, 10208.132308753764, 10209.642662506776, 10216.795664086676, 40426.19147617031, 40758.18483630311, 40808.38787418191, 40820.0, 40828.59171408277, 3476.3394954958476, 3518.5074089627474, 3587.802670853102, 3779.4708740776036, 3813.80930953454, 30037.849810751024, 30128.09615711532, 30335.241618959702, 30337.848310758305, 30866.228344291347, 4031.6746117481703, 4129.194807012634, 4133.235351459959, 4145.813438395279, 4179.958200417987, 322084.0, 322448.0, 322778.0, 323641.9999999977, 323908.0, 51488.48511514912, 51830.22254666183, 52244.738776306636, 52321.7383913078, 58883.70558147268, 54993.0, 55063.44936550663, 55192.0, 55207.44792552103, 55270.44729552734, 14997.250137493082, 15328.846711532742, 15342.769858452131, 15350.07899526032, 15355.385784568492, 11107.722306942229, 11319.886801132048, 11723.472443740053, 11970.024945884006, 12290.139690221598, 17580.648387032186, 17884.55288617795, 17986.19062142207, 17999.2800287987, 18109.7283540747, 5746.224259724967, 5773.134029895549, 5773.422657734277, 5845.795397161079, 5927.436893495111, 889.7953470701775, 1066.424130969268, 1071.892810718922, 1078.7626722121122, 1104.2987702808775, 30752.69247307543, 30881.0, 31166.844165779024, 31466.528002079987, 31675.20811979719, 1029.53156313877, 1061.9681409557725, 1077.8975997280245, 1106.9169812264113, 1124.6457365929707, 15595.0, 16269.430569930233, 16330.183490825411, 16512.504624861274, 16635.251413686412, 449868.0, 450381.0, 451878.0, 452051.0, 452718.0, 57392.13911791326, 57651.423485765445, 57659.71170144122, 57705.42294577084, 57721.4227857716, 1202.2305724336431, 1242.589945318043, 1242.67069226655, 1328.6014195741238, 1336.8195293635235, 30174.0, 34125.31749365049, 34364.31271374608, 34462.1045842481, 34474.31051378908, 55522.0, 55964.16053759278, 56011.0, 56296.43703562912, 56353.71823140858, 457142.0, 458787.0, 460686.0, 461064.0, 464339.0, 34635.307293853475, 35040.0, 35917.0, 36037.09907252339, 41181.0, 43761.56238437702, 44072.55927440813, 44386.77806611075, 45478.77260613808, 45549.54450455453, 36767.63232367642, 36970.44544331891, 37671.0, 37687.2462550742, 39048.41427378535, 36723.63276367202, 37225.90515043289, 37355.0, 37597.248055039294, 38008.619913801616, 37495.81252093722, 37631.62368376281, 38193.618063819005, 38251.426228607146, 38268.80865595654, 30042.849785750932, 33612.327753445286, 33883.66116338805, 33978.150546235556, 33990.32019359648, 25533.3616659585, 25787.742122578533, 26148.73851261463, 26151.0, 26272.60591091097], "value": 19727.41147442271, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.1842656714631, 386.1751289318636, 386.83559487217934, 392.7309792791938, 415.1572308214326, 14312.499062532814, 15016.324265408055, 17311.047892365914, 18715.906420467894, 18747.718784218247, 16982.915085424556, 17097.0, 17123.657526849485, 17363.218655160515, 18106.90946545269, 5486.972565137169, 5510.531604813596, 5691.800786972457, 5733.397993210715, 5742.425757424245, 5556.194351818984, 5675.602707810455, 5683.914741278884, 5685.744141513642, 5686.744096515646, 5408.404520666413, 5519.199716041172, 5607.691576963265, 5653.632513886584, 5655.4061823508555, 5570.498655121039, 5613.186088017214, 5622.072358060936, 5623.212750214973, 5623.409541998092, 4843.975780121077, 5017.122003649383, 5030.2957585938, 5043.394792624872, 5049.722265275408, 18184.0, 18274.36039738616, 18942.810571894242, 21360.145594176214, 21667.0, 2145.914163433461, 2410.3853517353136, 2423.903043878243, 2488.925332240036, 2888.5522743974716, 9571.664991725325, 9699.369540979813, 9942.204623630092, 9950.0, 10202.183825293958, 1857.823506766855, 1958.392898201562, 1971.2312198242696, 1975.2790231565518, 1985.8907760073191, 72578.0, 74033.6298318505, 76723.0, 78343.0, 78684.21315786826, 10562.0, 10627.734306642242, 10652.893471065345, 10948.507317170746, 10987.835182472269, 13199.274039927896, 14686.41254349814, 14798.852011479747, 14801.111933283823, 14825.481108161162, 6958.416415545998, 7434.888476672854, 7741.61291935401, 7751.92248077512, 7853.253940875607, 7086.078809754699, 7217.783575194254, 7226.66306733256, 7349.265073492608, 7377.4098072155175, 4507.0, 4560.840370587013, 4561.407017087758, 4566.543345665407, 4681.602063824613, 1889.8015708350424, 1908.1508728615634, 1930.903454827253, 1946.8345190658952, 1973.2600274896913, 812.4312980913385, 939.3002213351098, 974.468914441631, 980.0983095552109, 1011.2567263061644, 17614.383496577557, 18395.63208735818, 18917.81082189188, 19047.42857714271, 19194.0, 968.6173961285253, 974.4153507895206, 998.1415982255255, 1001.4191768774093, 1008.6973907827622, 8025.719099831478, 9827.4103553787, 10091.340154729223, 10701.678949631523, 10844.457777111113, 311810.0, 428438.0, 432445.0, 435901.0, 443559.0, 91555.0, 92998.53500732454, 94281.52859235796, 94544.52727736317, 94950.52524737333, 948.1608776233084, 988.851672249154, 993.8658281132099, 994.6419289055934, 1006.0492834271544, 15147.924260378628, 16294.592635184215, 16971.490855274362, 17141.657166856843, 17188.570285742957, 37703.0, 38946.4158037624, 39564.0, 40515.0, 41655.37516937188, 53428.1985770206, 53519.46480535145, 53621.463785361644, 54112.729436352565, 55087.44912550823, 7747.883781743166, 8102.0, 8124.959375203086, 8410.116937721696, 8448.40861139739, 11306.94346528262, 11886.405679716152, 12251.938740306241, 12291.815622765487, 12760.361981901053, 10307.94846025765, 10527.263091583822, 10560.419176945341, 10919.0, 11158.832617510581, 10727.195460340661, 10768.892311076788, 10902.727431814268, 10922.399268040333, 11290.887091128983, 10794.622188223375, 10813.297135686154, 10875.673729788119, 11056.502457389275, 11477.942610286895, 8022.077461092049, 8217.219364160395, 8236.917630823855, 8504.574771261536, 8557.828843423222, 9637.22902167839, 10505.68482945513, 10532.94229914101, 10601.098906593026, 10632.362058276529], "value": 8737.987678053598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.6169080121374, 1380.8757211850932, 1383.2184815579194, 1489.5754709907678, 1719.922603482844, 7365.189829118799, 7729.690812367506, 7980.680772769082, 8054.43618946674, 8240.91759082409, 7998.440109192359, 8090.838183236332, 8121.269085782278, 8129.6748130074875, 8130.065042520112, 1931.642646110474, 2107.272990818169, 2140.636091864379, 2153.7092492513543, 2155.0948601587293, 1987.0958713785265, 2176.62997290461, 2241.529278851443, 2244.1584405847807, 2255.76314486979, 2173.1416090644266, 2174.3150907464096, 2189.9890500547476, 2191.2111639809655, 2200.9559808803815, 2158.4927542027613, 2179.3788770200417, 2182.0, 2182.2471247419617, 2184.486645638274, 2142.4322554523064, 2190.9342719718434, 2195.868247905131, 2197.6703494475796, 2204.7244094488187, 8188.426810123294, 8403.663853445854, 8414.242718155334, 8417.70538031166, 8436.240738333518, 5073.974630126862, 5163.457836927106, 5233.659812112201, 5233.764480598382, 5240.0, 3190.6649801770714, 3322.285708572644, 3472.6700963408434, 3478.113081164287, 3495.825208739578, 1017.8218811707995, 1082.506141524691, 1105.7733164701217, 1110.4392281897672, 1129.2603344809163, 11738.941305293505, 11752.0, 11755.05959523236, 11755.294682319003, 11773.764524709544, 4457.0834541147615, 4547.636189104864, 4625.306204069349, 4648.5119062498625, 4649.395578574764, 9144.085591440802, 9198.0, 9206.63173473067, 9207.677731279373, 9218.124278193562, 5042.697438153723, 5076.238564215398, 5129.358830146231, 5134.152864777345, 5137.743112844343, 4288.52826189119, 4443.488998765119, 4695.765211739399, 4782.0, 4800.615950724004, 3549.716022718176, 3625.1118475973026, 3685.852565897334, 3714.665680088805, 3727.1241258304276, 1102.6581759654373, 1106.8616422947132, 1131.8189089745765, 1133.7562424078862, 1139.800534906388, 831.1807245705971, 837.995810020946, 888.4225253585092, 906.4923642760075, 930.4556834252038, 5482.396936337, 5651.463111004448, 5662.518685911661, 5722.084466485342, 5728.684922329228, 898.4429653614801, 902.0348227396754, 917.8247553298725, 923.3997901364168, 927.1053433436766, 3787.9431808522895, 3870.9419358709642, 3887.8056097195026, 3903.765774053566, 3910.1202229498704, 10138.645147419953, 10597.788044239072, 10605.204609654307, 10615.787684246427, 10619.09737672291, 10447.111995480318, 10450.738731531772, 10497.580096796042, 10503.264771466076, 10511.26421150512, 7402.518836275625, 7857.214278572097, 8010.399220058519, 8016.79958001043, 8022.839543209103, 5570.749316280696, 5647.15292706081, 5673.744681489426, 5720.599558030898, 5848.94151058501, 9323.813523729352, 9387.389819661701, 9418.387804792666, 9499.525023748924, 9518.333716639769, 8998.190162885372, 9051.773705657411, 9133.862992055258, 9207.76980575491, 9426.905730942603, 6600.60396376219, 6769.966150169218, 7181.892271615826, 7567.281108294703, 7584.734534291273, 7683.308502234826, 7913.723019694283, 7955.4828936118965, 8140.959295203486, 8166.6733330668485, 7216.170140433917, 7325.120985481776, 7375.151857536452, 7459.552426854406, 7602.619869006417, 7044.189918159477, 7233.855322893618, 7264.818379540554, 7404.222556631476, 7493.962530187532, 6597.736090556516, 6653.833654158685, 6675.332466753286, 6677.966610166918, 6683.933160668331, 4778.641601879943, 4802.303665968485, 5055.064813009458, 5087.211482220262, 5121.257417674342, 4910.803567857246, 4972.508008102828, 5031.798728050837, 5072.239164125411, 5116.130257856248], "value": 4385.611965815765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.7413549312241, 380.1446744824146, 384.3619591478145, 385.95175603049637, 387.7150294533516, 5079.56823669988, 5144.8971020579565, 5161.819336323234, 5170.327857378536, 5203.8143979528595, 5009.171652346895, 5131.461196574362, 5152.093725321627, 5153.144867847581, 5169.870753231171, 4101.405296232045, 4118.670506359484, 4142.316517774579, 4149.3775933609895, 4156.480439945007, 4109.6506796922295, 4117.114820313632, 4119.526254480728, 4126.628603425691, 4129.339305711087, 4043.65628921542, 4046.372812214097, 4069.9796501017454, 4142.8135733891895, 4147.253494371012, 3973.6622387096986, 4046.473958385391, 4052.1693052924375, 4055.270051390734, 4061.8578349757618, 3678.889633311005, 3683.4658974448553, 3699.85200591976, 3703.814809259526, 3704.1665625234377, 4945.7774400152075, 4966.55301022906, 4980.402351717781, 4980.576650984671, 4990.775415106329, 4361.520232774392, 4584.885377865547, 4594.563516465931, 4676.906461870778, 4678.830292426894, 5345.7594408251725, 5368.289014047881, 5378.946210537883, 5388.0, 5395.0, 3897.0, 3922.7646341219333, 3936.563154448634, 3943.3493473576827, 3952.9011774705864, 5293.364796224478, 5445.292112025451, 5480.506754392084, 5498.065328894098, 5517.613767036309, 3956.408552398126, 3959.4456776051375, 3977.7613343198923, 3979.900502487461, 3991.0, 4014.6788256939376, 4016.9397459038137, 4033.3949907514107, 4048.2105989332385, 4061.7156799023783, 4443.4445694288215, 4596.35651008859, 4628.629709623289, 4644.58198762113, 4664.207084795593, 5376.91934620981, 5400.6498375406145, 5408.91886621701, 5435.456454354533, 5443.646162999472, 1359.9048066635241, 1362.8364596248316, 1363.5159518370835, 1370.8492065872945, 1375.559820857316, 893.4148132972913, 932.9346945713735, 933.3093510801957, 938.5635679409107, 945.7682867697458, 5037.420696619863, 5038.571721403721, 5052.898942021139, 5058.924116138187, 5083.593312534988, 5293.867653308621, 5316.644255714768, 5366.946330536723, 5386.114859799039, 5395.3525576931015, 4981.576565991859, 5086.4659210783075, 5093.5228783653065, 5101.7194054327365, 5274.446183150714, 2858.799884008141, 2870.167651381076, 2877.6690680571583, 2881.6686081100943, 2883.1494709060876, 5554.250176226158, 5589.105743081088, 5594.804181853616, 5608.495235428831, 5621.690807005572, 5403.0, 5404.594655400861, 5507.925954438926, 5664.065429204217, 5703.74333155009, 5605.691686957257, 5633.718314084362, 5686.857828554319, 5689.6586204827845, 5705.85882823437, 5534.4742249486235, 5565.55475561946, 5565.777368905198, 5583.581231407579, 5594.776208951596, 5261.23748544242, 5524.171374293888, 5548.278723766046, 5564.386327965007, 5581.465097098168, 5686.573506987075, 5695.601307908407, 5717.714114294352, 5725.656460612377, 5735.885282294247, 3988.980055099706, 4014.759114453142, 4018.598140186075, 4038.4346191532622, 4060.939085913773, 5428.402875683751, 5498.80754173602, 5538.0, 5539.7784088636, 5664.892952609325, 5416.8104116355735, 5417.485338892799, 5419.292922729328, 5423.891522169613, 5445.863853403696, 5333.973330133324, 5420.945790542044, 5441.972790136024, 5453.672779633234, 5499.725013749377, 5334.626576139633, 5346.759395827275, 5355.812546560852, 5363.946360536501, 5407.161889907071, 5387.676739395649, 5449.0, 5455.563554915518, 5465.0, 5477.274658482565, 5160.148575485003, 5334.466553344634, 5375.0, 5378.19327100938, 5444.673319600836], "value": 4146.6675647561515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.4641667041363, 675.959442433454, 691.0739608924044, 724.3878922310649, 778.2762031310882, 13908.0, 14021.929890350546, 14105.92947035266, 14568.854311456882, 14669.92665036676, 12273.631791046282, 13427.127236729606, 13559.050866439353, 13590.25253611051, 13608.387622556984, 651.7555916531301, 683.0471492268283, 792.1247022040662, 802.257911431926, 809.2837838512929, 746.3096635612064, 789.8143936174994, 796.928276455119, 800.0359566722115, 804.8470790549806, 846.8306338732248, 848.2196379331, 849.5072857742495, 849.9065102838683, 849.9830003399928, 689.2521614048763, 719.3741444942907, 722.2055738687454, 724.851405461879, 847.3094428041157, 589.7906243283616, 612.5130521235628, 612.8161551534522, 615.0681717198448, 615.8398816307747, 12700.936495317465, 12725.754932492247, 12752.936235318764, 12755.043371747157, 12755.362231888368, 13816.792748108786, 13882.305884705724, 13889.722205555934, 13937.930310348485, 14071.366788494543, 11485.0811935045, 11633.76732465346, 11768.411579420994, 11889.167758256925, 12168.634940951786, 4242.575742425764, 4374.0, 4427.2695005324085, 4456.598906098434, 4473.485549161823, 64787.493063090165, 71228.64385678091, 72362.0, 72757.0, 73391.26608733898, 10338.844917326247, 10509.789804203872, 10616.150707943347, 10618.575256989789, 10822.945885270523, 20788.064537095866, 20790.688139677917, 20866.47833804167, 21079.26222582233, 21381.0, 7886.881696774438, 8163.7142700005215, 8240.299574536231, 8257.463264887883, 8694.043655197924, 4366.890827729332, 4401.6478681705385, 4533.52397998212, 4639.30410438437, 4668.533146685372, 3214.9357012860078, 3322.5016247562576, 3325.1687078230443, 3325.8004519728893, 3327.03515980363, 589.0927970924813, 590.2769107842859, 600.6996501749126, 602.3735315272155, 612.0941007309208, 555.4667519181551, 637.9187277564483, 666.73997141115, 698.4552049401475, 718.4252597921642, 8137.389695772841, 8613.612387442456, 8662.2637075848, 8945.418547794372, 9122.635094596142, 584.6579750845802, 586.8092869817326, 596.5704692621306, 614.0390289197392, 720.9819754506075, 3992.700547458894, 4346.21768081742, 4352.934705979413, 4380.233459144637, 4386.210482113186, 78565.21434785693, 80516.0, 81261.0, 81600.59199703964, 82724.58637706772, 68512.65743671349, 70770.64614676894, 70905.64547177334, 72983.2701672987, 73386.0, 62775.0, 63184.684076579324, 63505.364946349946, 63861.36138638554, 64272.357276426636, 8189.181081892001, 8300.792480187802, 8324.822518370906, 8388.832223355621, 8455.112213217524, 38686.613133868304, 41201.283448117596, 42402.363964541175, 43015.784921075196, 44851.32723009092, 43650.34524482072, 44625.0, 52430.47569524256, 52733.0, 54379.0, 12203.755924881276, 12868.613941581767, 12890.548830790878, 12897.935510322388, 13285.66785830362, 14124.152550846982, 14267.07264027835, 14449.0, 14651.560453186421, 14747.483838065617, 13333.599992000256, 13431.462741490232, 13804.447822087004, 13952.099682024515, 14086.718265634834, 11613.883861161617, 11867.821982670439, 11994.500121612682, 12136.0, 12330.260184388966, 12550.937245313715, 12800.871991279968, 13400.195988240737, 13499.257540835348, 14397.064190827563, 10679.305845120043, 10960.213945288622, 11352.772944541228, 11544.538218471167, 11817.940910295394, 10434.69566304212, 10693.786124277627, 11016.50425730828, 11188.66434006981, 11225.887741122811], "value": 6898.724812061997, "unit": "score"}], "name": "dromaeo_css", "value": 6963.870113484542, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 113.0, 116.0, 113.0, 113.0, 114.0, 115.0, 112.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 124.0, 161.0, 128.0, 124.0, 122.0, 124.0, 145.0, 124.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 107.0, 77.0, 77.0, 77.0, 75.0, 107.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 114.0, 85.0, 86.0, 85.0, 102.0, 84.0, 85.0, 110.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 126.0, 127.0], "value": 126.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 55.0, 52.0, 53.0, 54.0, 52.0, 54.0, 52.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 65.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 80.0, 80.0, 81.0, 81.0, 81.0, 81.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 148.0, 131.0, 140.0, 134.0, 132.0, 135.0, 189.0, 136.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 169.0, 176.0, 177.0, 166.0, 170.0, 166.0, 168.0, 167.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 74.0, 64.0, 65.0, 64.0, 64.0, 63.0, 63.0, 63.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1524.4999999999995, "alertThreshold": 2.0}]} 05:14:31 INFO - Return code: 0 05:14:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:14:31 INFO - # TBPL SUCCESS # 05:14:31 INFO - Running post-action listener: _resource_record_post_action 05:14:31 INFO - [mozharness: 2016-12-15 13:14:31.430895Z] Finished run-tests step (success) 05:14:31 INFO - Running post-run listener: _resource_record_post_run 05:14:31 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404168704; Read time: 16; Write time: 276032 05:14:31 INFO - TinderboxPrint: CPU usage
13.1% 05:14:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:14:31 INFO - TinderboxPrint: I/O write bytes / time
404,168,704 / 276,032 05:14:31 INFO - TinderboxPrint: CPU idle
8,294.6 (86.8%) 05:14:31 INFO - TinderboxPrint: CPU user
1,204.7 (12.6%) 05:14:31 INFO - TinderboxPrint: Swap in / out
0 / 0 05:14:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104124416; Read time: 0; Write time: 83524 05:14:31 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288829440; Read time: 0; Write time: 190524 05:14:32 INFO - Running post-run listener: _upload_blobber_files 05:14:32 INFO - Blob upload gear active. 05:14:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:14:32 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 05:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:14:32 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:14:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:33 INFO - (blobuploader) - INFO - Done attempting. 05:14:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:14:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:14:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:36 INFO - (blobuploader) - INFO - Done attempting. 05:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:14:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:37 INFO - (blobuploader) - INFO - Done attempting. 05:14:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:37 INFO - Return code: 0 05:14:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58623919a62de67f6b86f7b487779491af07c64c1cc0f1d35176aae81706c095b3d7571015c09cc9d810a113fcb9062f2a3dc595b9e9b6148d6007cd46854600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d2791b41e8f2c5337645ee2c374b12ed5e0ed62aa7eaf4dfaa7b42ec05942313f0fe1e705f788cdff5b0860a75c7f44defe05ddfa8b2dcbab395cec1fc9fd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/517c3557d58ae295f7edcc1912906366ea4d3e14a3599f79ddba27d9e9dbf8a58ad643fec556556ba28aa159e1d6affb809236f1e7e8e99c61483163b0787c39"} 05:14:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:37 INFO - Contents: 05:14:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58623919a62de67f6b86f7b487779491af07c64c1cc0f1d35176aae81706c095b3d7571015c09cc9d810a113fcb9062f2a3dc595b9e9b6148d6007cd46854600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d2791b41e8f2c5337645ee2c374b12ed5e0ed62aa7eaf4dfaa7b42ec05942313f0fe1e705f788cdff5b0860a75c7f44defe05ddfa8b2dcbab395cec1fc9fd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/517c3557d58ae295f7edcc1912906366ea4d3e14a3599f79ddba27d9e9dbf8a58ad643fec556556ba28aa159e1d6affb809236f1e7e8e99c61483163b0787c39"} 05:14:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:37 INFO - Copying logs to upload dir... 05:14:37 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.741711 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-12-15 05:14:37.160048) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 05:14:37.163907) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58623919a62de67f6b86f7b487779491af07c64c1cc0f1d35176aae81706c095b3d7571015c09cc9d810a113fcb9062f2a3dc595b9e9b6148d6007cd46854600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d2791b41e8f2c5337645ee2c374b12ed5e0ed62aa7eaf4dfaa7b42ec05942313f0fe1e705f788cdff5b0860a75c7f44defe05ddfa8b2dcbab395cec1fc9fd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/517c3557d58ae295f7edcc1912906366ea4d3e14a3599f79ddba27d9e9dbf8a58ad643fec556556ba28aa159e1d6affb809236f1e7e8e99c61483163b0787c39"} build_url:https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/Ej3TQOX4QuWKjNNps7qdhA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58623919a62de67f6b86f7b487779491af07c64c1cc0f1d35176aae81706c095b3d7571015c09cc9d810a113fcb9062f2a3dc595b9e9b6148d6007cd46854600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d2791b41e8f2c5337645ee2c374b12ed5e0ed62aa7eaf4dfaa7b42ec05942313f0fe1e705f788cdff5b0860a75c7f44defe05ddfa8b2dcbab395cec1fc9fd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/517c3557d58ae295f7edcc1912906366ea4d3e14a3599f79ddba27d9e9dbf8a58ad643fec556556ba28aa159e1d6affb809236f1e7e8e99c61483163b0787c39"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 05:14:37.189504) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:14:37.189839) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481806258.319546-618164621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:14:37.273276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 05:14:37.273597) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 05:14:37.273880) ========= ========= Total master_lag: 0.17 =========