builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1480778583.1 results: success (0) buildid: 20161203062943 builduid: 05fb224fd87f4147b7d331f5f89834fd revision: f664a80393daca803f15055ade0c85145883f3ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:03.106238) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:03.107107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:03.107678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:03.124481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:03.124861) ========= 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=6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-03 07:23:04-- 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% 228M=0s 2016-12-03 07:23:04 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:03.250304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:03.250683) ========= 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=6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022014 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:03.301809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-03 07:23:03.302366) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f664a80393daca803f15055ade0c85145883f3ff --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 f664a80393daca803f15055ade0c85145883f3ff --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=6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-03 07:23:04,557 truncating revision to first 12 chars 2016-12-03 07:23:04,557 Setting DEBUG logging. 2016-12-03 07:23:04,557 attempt 1/10 2016-12-03 07:23:04,557 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f664a80393da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-03 07:23:05,336 unpacking tar archive at: mozilla-central-f664a80393da/testing/mozharness/ program finished with exit code 0 elapsedTime=1.094979 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-03 07:23:04.411439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:04.411779) ========= script_repo_revision: f664a80393daca803f15055ade0c85145883f3ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:04.412240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:04.412576) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 07:23:04.422712) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-03 07:23:04.423153) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:23:05 INFO - MultiFileLogger online at 20161203 07:23:05 in /builds/slave/test 07:23:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:23:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:23:05 INFO - {'append_to_log': False, 07:23:05 INFO - 'base_work_dir': '/builds/slave/test', 07:23:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:23:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:23:05 INFO - 'branch': 'Firefox-Non-PGO', 07:23:05 INFO - 'buildbot_json_path': 'buildprops.json', 07:23:05 INFO - 'config_files': ('talos/linux_config.py',), 07:23:05 INFO - 'default_actions': ('clobber', 07:23:05 INFO - 'read-buildbot-config', 07:23:05 INFO - 'download-and-extract', 07:23:05 INFO - 'populate-webroot', 07:23:05 INFO - 'create-virtualenv', 07:23:05 INFO - 'install', 07:23:05 INFO - 'run-tests'), 07:23:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:23:05 INFO - 'download_minidump_stackwalk': True, 07:23:05 INFO - 'download_symbols': 'ondemand', 07:23:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:23:05 INFO - 'tooltool.py': '/tools/tooltool.py', 07:23:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:23:05 INFO - '/tools/misc-python/virtualenv.py')}, 07:23:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:23:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:23:05 INFO - 'installer_path': 'installer.exe', 07:23:05 INFO - 'log_level': 'info', 07:23:05 INFO - 'log_name': 'talos', 07:23:05 INFO - 'log_to_console': True, 07:23:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:23:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:23:05 INFO - 'opt_config_files': (), 07:23:05 INFO - 'pip_index': False, 07:23:05 INFO - 'sps_profile': False, 07:23:05 INFO - 'sps_profile_interval': 0, 07:23:05 INFO - 'suite': 'dromaeojs', 07:23:05 INFO - 'system_bits': '32', 07:23:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:23:05 INFO - 'title': 'talos-linux64-ix-023', 07:23:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:23:05 INFO - 'use_talos_json': True, 07:23:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:23:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:23:05 INFO - 'work_dir': 'build'} 07:23:05 INFO - [mozharness: 2016-12-03 15:23:05.775081Z] Running clobber step. 07:23:05 INFO - Running pre-action listener: _resource_record_pre_action 07:23:05 INFO - Running main action method: clobber 07:23:05 INFO - rmtree: /builds/slave/test/build 07:23:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:23:06 INFO - Running post-action listener: _resource_record_post_action 07:23:06 INFO - [mozharness: 2016-12-03 15:23:06.233624Z] Finished clobber step (success) 07:23:06 INFO - [mozharness: 2016-12-03 15:23:06.233724Z] Running read-buildbot-config step. 07:23:06 INFO - Running pre-action listener: _resource_record_pre_action 07:23:06 INFO - Running main action method: read_buildbot_config 07:23:06 INFO - Using buildbot properties: 07:23:06 INFO - { 07:23:06 INFO - "project": "", 07:23:06 INFO - "product": "firefox", 07:23:06 INFO - "script_repo_revision": "production", 07:23:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:23:06 INFO - "repository": "", 07:23:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:23:06 INFO - "buildid": "20161203062943", 07:23:06 INFO - "pgo_build": "False", 07:23:06 INFO - "basedir": "/builds/slave/test", 07:23:06 INFO - "buildnumber": 325, 07:23:06 INFO - "slavename": "talos-linux64-ix-023", 07:23:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:23:06 INFO - "platform": "ubuntu64_hw", 07:23:06 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:23:06 INFO - "branch": "mozilla-central", 07:23:06 INFO - "repo_path": "mozilla-central", 07:23:06 INFO - "revision": "f664a80393daca803f15055ade0c85145883f3ff", 07:23:06 INFO - "stage_platform": "linux64", 07:23:06 INFO - "builduid": "05fb224fd87f4147b7d331f5f89834fd", 07:23:06 INFO - "slavebuilddir": "test" 07:23:06 INFO - } 07:23:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:23:06 INFO - Running post-action listener: _resource_record_post_action 07:23:06 INFO - [mozharness: 2016-12-03 15:23:06.236159Z] Finished read-buildbot-config step (success) 07:23:06 INFO - [mozharness: 2016-12-03 15:23:06.236248Z] Running download-and-extract step. 07:23:06 INFO - Running pre-action listener: _resource_record_pre_action 07:23:06 INFO - Running main action method: download_and_extract 07:23:06 INFO - mkdir: /builds/slave/test/build/tests 07:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:06 INFO - trying https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:23:06 INFO - Downloading https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:23:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:23:06 INFO - Downloaded 1361 bytes. 07:23:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:23:06 INFO - Using the following test package requirements: 07:23:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:23:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:23:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:23:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:06 INFO - u'jsshell-linux-x86_64.zip'], 07:23:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:23:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:23:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:23:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:23:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:23:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:23:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:23:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:23:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:23:06 INFO - Fetch https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:23:07 INFO - Expected file size: 20218590 07:23:07 INFO - Obtained file size: 20218590 07:23:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:23:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:23:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:23:11 INFO - Fetch https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:23:12 INFO - Expected file size: 20218590 07:23:12 INFO - Obtained file size: 20218590 07:23:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:23:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:23:16 INFO - Fetch https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:23:17 INFO - Expected file size: 14409734 07:23:17 INFO - Obtained file size: 14409734 07:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:18 INFO - trying https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:23:18 INFO - Downloading https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:23:20 INFO - Downloaded 55701142 bytes. 07:23:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:23:20 INFO - mkdir: /builds/slave/test/properties 07:23:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:23:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:23:20 INFO - Contents: 07:23:20 INFO - build_url:https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:23:21 INFO - Running post-action listener: _resource_record_post_action 07:23:21 INFO - Running post-action listener: set_extra_try_arguments 07:23:21 INFO - [mozharness: 2016-12-03 15:23:21.391945Z] Finished download-and-extract step (success) 07:23:21 INFO - [mozharness: 2016-12-03 15:23:21.392172Z] Running populate-webroot step. 07:23:21 INFO - Running pre-action listener: _resource_record_pre_action 07:23:21 INFO - Running main action method: populate_webroot 07:23:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:23:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:23:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:23:21 INFO - '--tppagecycles', 07:23:21 INFO - '7'], 07:23:21 INFO - 'tests': ['tsvgm']}}, 07:23:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:23:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:23:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:23:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:23:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:23:21 INFO - 'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:23:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:23:21 INFO - 'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['damp', 'tps']}, 07:23:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:23:21 INFO - 'tests': ['damp', 'tps']}, 07:23:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['dromaeo_dom']}, 07:23:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:23:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['basic_compositor_video']}, 07:23:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:23:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['a11yr', 07:23:21 INFO - 'ts_paint', 07:23:21 INFO - 'tpaint', 07:23:21 INFO - 'sessionrestore', 07:23:21 INFO - 'sessionrestore_no_auto_restore', 07:23:21 INFO - 'tabpaint']}, 07:23:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:23:21 INFO - 'ts_paint', 07:23:21 INFO - 'tpaint', 07:23:21 INFO - 'sessionrestore', 07:23:21 INFO - 'sessionrestore_no_auto_restore', 07:23:21 INFO - 'tabpaint']}, 07:23:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:23:21 INFO - 'ts_paint', 07:23:21 INFO - 'tpaint', 07:23:21 INFO - 'sessionrestore', 07:23:21 INFO - 'sessionrestore_no_auto_restore', 07:23:21 INFO - 'tabpaint']}, 07:23:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:23:21 INFO - 'ts_paint', 07:23:21 INFO - 'tpaint', 07:23:21 INFO - 'sessionrestore', 07:23:21 INFO - 'sessionrestore_no_auto_restore', 07:23:21 INFO - 'tabpaint']}, 07:23:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['a11yr', 07:23:21 INFO - 'ts_paint', 07:23:21 INFO - 'tpaint', 07:23:21 INFO - 'sessionrestore', 07:23:21 INFO - 'sessionrestore_no_auto_restore', 07:23:21 INFO - 'tabpaint']}, 07:23:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['a11yr', 07:23:21 INFO - 'ts_paint', 07:23:21 INFO - 'tpaint', 07:23:21 INFO - 'sessionrestore', 07:23:21 INFO - 'sessionrestore_no_auto_restore', 07:23:21 INFO - 'tabpaint']}, 07:23:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['tsvgx', 07:23:21 INFO - 'tsvgr_opacity', 07:23:21 INFO - 'tart', 07:23:21 INFO - 'tscrollx', 07:23:21 INFO - 'cart', 07:23:21 INFO - 'tsvg_static']}, 07:23:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:23:21 INFO - 'tsvgr_opacity', 07:23:21 INFO - 'tart', 07:23:21 INFO - 'tscrollx', 07:23:21 INFO - 'cart', 07:23:21 INFO - 'tsvg_static']}, 07:23:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:23:21 INFO - 'talos_options': ['--disable-e10s'], 07:23:21 INFO - 'tests': ['tp5o']}, 07:23:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:23:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:23:21 INFO - 'talos_options': ['--disable-e10s', 07:23:21 INFO - '--xperf_path', 07:23:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:21 INFO - 'tests': ['tp5n']}, 07:23:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:23:21 INFO - 'talos_options': ['--xperf_path', 07:23:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:21 INFO - 'tests': ['tp5n']}}, 07:23:21 INFO - 'talos.zip': {'path': '', 07:23:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:23:21 INFO - Running post-action listener: _resource_record_post_action 07:23:21 INFO - [mozharness: 2016-12-03 15:23:21.407595Z] Finished populate-webroot step (success) 07:23:21 INFO - [mozharness: 2016-12-03 15:23:21.407724Z] Running create-virtualenv step. 07:23:21 INFO - Running pre-action listener: _resource_record_pre_action 07:23:21 INFO - Running main action method: create_virtualenv 07:23:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:23:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:23:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:23:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:23:21 INFO - Using real prefix '/usr' 07:23:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:23:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:23:23 INFO - Installing pip.................done. 07:23:23 INFO - Return code: 0 07:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:23:24 INFO - Reading from file tmpfile_stdout 07:23:24 INFO - Output received: 07:23:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:23:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401273e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:23:24 INFO - Using env: {'DISPLAY': ':0', 07:23:24 INFO - 'HOME': '/home/cltbld', 07:23:24 INFO - 'LANG': 'en_US.UTF-8', 07:23:24 INFO - 'LANGUAGE': 'en_US:en', 07:23:24 INFO - 'LOGNAME': 'cltbld', 07:23:24 INFO - 'MAIL': '/var/mail/cltbld', 07:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:24 INFO - 'MOZ_NO_REMOTE': '1', 07:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:24 INFO - 'NO_EM_RESTART': '1', 07:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:24 INFO - 'PWD': '/builds/slave/test', 07:23:24 INFO - 'SHELL': '/bin/bash', 07:23:24 INFO - 'SHLVL': '1', 07:23:24 INFO - 'TERM': 'linux', 07:23:24 INFO - 'TMOUT': '86400', 07:23:24 INFO - 'USER': 'cltbld', 07:23:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:24 INFO - '_': '/tools/buildbot/bin/python'} 07:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:23:24 INFO - Cleaning up... 07:23:24 INFO - Return code: 0 07:23:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff401273e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:23:24 INFO - Using env: {'DISPLAY': ':0', 07:23:24 INFO - 'HOME': '/home/cltbld', 07:23:24 INFO - 'LANG': 'en_US.UTF-8', 07:23:24 INFO - 'LANGUAGE': 'en_US:en', 07:23:24 INFO - 'LOGNAME': 'cltbld', 07:23:24 INFO - 'MAIL': '/var/mail/cltbld', 07:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:24 INFO - 'MOZ_NO_REMOTE': '1', 07:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:24 INFO - 'NO_EM_RESTART': '1', 07:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:24 INFO - 'PWD': '/builds/slave/test', 07:23:24 INFO - 'SHELL': '/bin/bash', 07:23:24 INFO - 'SHLVL': '1', 07:23:24 INFO - 'TERM': 'linux', 07:23:24 INFO - 'TMOUT': '86400', 07:23:24 INFO - 'USER': 'cltbld', 07:23:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:24 INFO - '_': '/tools/buildbot/bin/python'} 07:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:24 INFO - Downloading/unpacking psutil>=3.1.1 07:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:23:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:26 INFO - Installing collected packages: psutil 07:23:26 INFO - Running setup.py install for psutil 07:23:26 INFO - building 'psutil._psutil_linux' extension 07:23:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:23:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:23:26 INFO - building 'psutil._psutil_posix' extension 07:23:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:23:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:23:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:27 INFO - Successfully installed psutil 07:23:27 INFO - Cleaning up... 07:23:27 INFO - Return code: 0 07:23:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:27 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 0x7ff401273e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:23:27 INFO - Using env: {'DISPLAY': ':0', 07:23:27 INFO - 'HOME': '/home/cltbld', 07:23:27 INFO - 'LANG': 'en_US.UTF-8', 07:23:27 INFO - 'LANGUAGE': 'en_US:en', 07:23:27 INFO - 'LOGNAME': 'cltbld', 07:23:27 INFO - 'MAIL': '/var/mail/cltbld', 07:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:27 INFO - 'MOZ_NO_REMOTE': '1', 07:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:27 INFO - 'NO_EM_RESTART': '1', 07:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:27 INFO - 'PWD': '/builds/slave/test', 07:23:27 INFO - 'SHELL': '/bin/bash', 07:23:27 INFO - 'SHLVL': '1', 07:23:27 INFO - 'TERM': 'linux', 07:23:27 INFO - 'TMOUT': '86400', 07:23:27 INFO - 'USER': 'cltbld', 07:23:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:27 INFO - '_': '/tools/buildbot/bin/python'} 07:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:23:29 INFO - Installing collected packages: mozsystemmonitor 07:23:29 INFO - Running setup.py install for mozsystemmonitor 07:23:29 INFO - Successfully installed mozsystemmonitor 07:23:29 INFO - Cleaning up... 07:23:29 INFO - Return code: 0 07:23:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:23: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')]} 07:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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')]} 07:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:29 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 0x7ff401273e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:23:29 INFO - Using env: {'DISPLAY': ':0', 07:23:29 INFO - 'HOME': '/home/cltbld', 07:23:29 INFO - 'LANG': 'en_US.UTF-8', 07:23:29 INFO - 'LANGUAGE': 'en_US:en', 07:23:29 INFO - 'LOGNAME': 'cltbld', 07:23:29 INFO - 'MAIL': '/var/mail/cltbld', 07:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:29 INFO - 'MOZ_NO_REMOTE': '1', 07:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:29 INFO - 'NO_EM_RESTART': '1', 07:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:29 INFO - 'PWD': '/builds/slave/test', 07:23:29 INFO - 'SHELL': '/bin/bash', 07:23:29 INFO - 'SHLVL': '1', 07:23:29 INFO - 'TERM': 'linux', 07:23:29 INFO - 'TMOUT': '86400', 07:23:29 INFO - 'USER': 'cltbld', 07:23:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:29 INFO - '_': '/tools/buildbot/bin/python'} 07:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:29 INFO - Downloading/unpacking jsonschema==2.5.1 07:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:23:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:32 INFO - Downloading functools32-3.2.3-2.tar.gz 07:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:23:32 INFO - warning: no files found matching '*.txt' 07:23:32 INFO - no previously-included directories found matching 'build' 07:23:32 INFO - no previously-included directories found matching 'dist' 07:23:32 INFO - no previously-included directories found matching '.git*' 07:23:32 INFO - Installing collected packages: jsonschema, functools32 07:23:32 INFO - Running setup.py install for functools32 07:23:32 INFO - warning: no files found matching '*.txt' 07:23:32 INFO - no previously-included directories found matching 'build' 07:23:32 INFO - no previously-included directories found matching 'dist' 07:23:32 INFO - no previously-included directories found matching '.git*' 07:23:32 INFO - Successfully installed jsonschema functools32 07:23:32 INFO - Cleaning up... 07:23:32 INFO - Return code: 0 07:23:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:32 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 0x7ff401273e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:23:32 INFO - Using env: {'DISPLAY': ':0', 07:23:32 INFO - 'HOME': '/home/cltbld', 07:23:32 INFO - 'LANG': 'en_US.UTF-8', 07:23:32 INFO - 'LANGUAGE': 'en_US:en', 07:23:32 INFO - 'LOGNAME': 'cltbld', 07:23:32 INFO - 'MAIL': '/var/mail/cltbld', 07:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:32 INFO - 'MOZ_NO_REMOTE': '1', 07:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:32 INFO - 'NO_EM_RESTART': '1', 07:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:32 INFO - 'PWD': '/builds/slave/test', 07:23:32 INFO - 'SHELL': '/bin/bash', 07:23:32 INFO - 'SHLVL': '1', 07:23:32 INFO - 'TERM': 'linux', 07:23:32 INFO - 'TMOUT': '86400', 07:23:32 INFO - 'USER': 'cltbld', 07:23:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:32 INFO - '_': '/tools/buildbot/bin/python'} 07:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:23:32 INFO - Cleaning up... 07:23:32 INFO - Return code: 0 07:23:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:32 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 0x7ff401273e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:23:32 INFO - Using env: {'DISPLAY': ':0', 07:23:32 INFO - 'HOME': '/home/cltbld', 07:23:32 INFO - 'LANG': 'en_US.UTF-8', 07:23:32 INFO - 'LANGUAGE': 'en_US:en', 07:23:32 INFO - 'LOGNAME': 'cltbld', 07:23:32 INFO - 'MAIL': '/var/mail/cltbld', 07:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:32 INFO - 'MOZ_NO_REMOTE': '1', 07:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:32 INFO - 'NO_EM_RESTART': '1', 07:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:32 INFO - 'PWD': '/builds/slave/test', 07:23:32 INFO - 'SHELL': '/bin/bash', 07:23:32 INFO - 'SHLVL': '1', 07:23:32 INFO - 'TERM': 'linux', 07:23:32 INFO - 'TMOUT': '86400', 07:23:32 INFO - 'USER': 'cltbld', 07:23:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:32 INFO - '_': '/tools/buildbot/bin/python'} 07:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:33 INFO - Downloading/unpacking blobuploader==1.2.4 07:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:35 INFO - Downloading blobuploader-1.2.4.tar.gz 07:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:23:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:23:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:35 INFO - Downloading docopt-0.6.1.tar.gz 07:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:23:35 INFO - Installing collected packages: blobuploader, requests, docopt 07:23:35 INFO - Running setup.py install for blobuploader 07:23:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:23:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:23:36 INFO - Running setup.py install for requests 07:23:36 INFO - Running setup.py install for docopt 07:23:36 INFO - Successfully installed blobuploader requests docopt 07:23:36 INFO - Cleaning up... 07:23:36 INFO - Return code: 0 07:23:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:36 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 0x7ff401273e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:23:36 INFO - Using env: {'DISPLAY': ':0', 07:23:36 INFO - 'HOME': '/home/cltbld', 07:23:36 INFO - 'LANG': 'en_US.UTF-8', 07:23:36 INFO - 'LANGUAGE': 'en_US:en', 07:23:36 INFO - 'LOGNAME': 'cltbld', 07:23:36 INFO - 'MAIL': '/var/mail/cltbld', 07:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:36 INFO - 'MOZ_NO_REMOTE': '1', 07:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:36 INFO - 'NO_EM_RESTART': '1', 07:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:36 INFO - 'PWD': '/builds/slave/test', 07:23:36 INFO - 'SHELL': '/bin/bash', 07:23:36 INFO - 'SHLVL': '1', 07:23:36 INFO - 'TERM': 'linux', 07:23:36 INFO - 'TMOUT': '86400', 07:23:36 INFO - 'USER': 'cltbld', 07:23:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:36 INFO - '_': '/tools/buildbot/bin/python'} 07:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:23:36 INFO - Running setup.py (path:/tmp/pip-72rXMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:23:36 INFO - Running setup.py (path:/tmp/pip-AJpbYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:23:36 INFO - Running setup.py (path:/tmp/pip-3GmjRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:23:36 INFO - Running setup.py (path:/tmp/pip-wU0NFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:23:37 INFO - Running setup.py (path:/tmp/pip-CTTzPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:23:37 INFO - Running setup.py (path:/tmp/pip-fBszMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:23:37 INFO - Running setup.py (path:/tmp/pip-5mHxFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:23:37 INFO - Running setup.py (path:/tmp/pip-3mrYGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:23:37 INFO - Running setup.py (path:/tmp/pip-A8l9u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:23:37 INFO - Running setup.py (path:/tmp/pip-35TyRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:23:37 INFO - Running setup.py (path:/tmp/pip-qpGy7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:23:37 INFO - Running setup.py (path:/tmp/pip-CQaKiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:23:37 INFO - Running setup.py (path:/tmp/pip-6zPHk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:23:37 INFO - Running setup.py (path:/tmp/pip-5Bdyhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:37 INFO - Running setup.py (path:/tmp/pip-yW5HHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:23:37 INFO - Running setup.py (path:/tmp/pip-T9o2Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:23:37 INFO - Running setup.py (path:/tmp/pip-fgMM0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:23:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:23:37 INFO - Running setup.py install for manifestparser 07:23:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:23:38 INFO - Running setup.py install for mozcrash 07:23:38 INFO - Running setup.py install for mozdebug 07:23:38 INFO - Running setup.py install for mozdevice 07:23:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:23:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:23:38 INFO - Running setup.py install for mozfile 07:23:38 INFO - Running setup.py install for mozhttpd 07:23:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:23:38 INFO - Running setup.py install for mozinfo 07:23:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:23:38 INFO - Running setup.py install for mozInstall 07:23:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:23:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:23:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:23:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:23:38 INFO - Running setup.py install for mozleak 07:23:38 INFO - Running setup.py install for mozlog 07:23:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Running setup.py install for moznetwork 07:23:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Running setup.py install for mozprocess 07:23:39 INFO - Running setup.py install for mozprofile 07:23:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Running setup.py install for mozrunner 07:23:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Running setup.py install for mozscreenshot 07:23:39 INFO - Running setup.py install for moztest 07:23:39 INFO - Running setup.py install for mozversion 07:23:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:23:39 INFO - Cleaning up... 07:23:39 INFO - Return code: 0 07:23:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:39 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 0x7ff401273e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:23:39 INFO - Using env: {'DISPLAY': ':0', 07:23:39 INFO - 'HOME': '/home/cltbld', 07:23:39 INFO - 'LANG': 'en_US.UTF-8', 07:23:39 INFO - 'LANGUAGE': 'en_US:en', 07:23:39 INFO - 'LOGNAME': 'cltbld', 07:23:39 INFO - 'MAIL': '/var/mail/cltbld', 07:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:39 INFO - 'MOZ_NO_REMOTE': '1', 07:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:39 INFO - 'NO_EM_RESTART': '1', 07:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:39 INFO - 'PWD': '/builds/slave/test', 07:23:39 INFO - 'SHELL': '/bin/bash', 07:23:39 INFO - 'SHLVL': '1', 07:23:39 INFO - 'TERM': 'linux', 07:23:39 INFO - 'TMOUT': '86400', 07:23:39 INFO - 'USER': 'cltbld', 07:23:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:39 INFO - '_': '/tools/buildbot/bin/python'} 07:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:23:39 INFO - Running setup.py (path:/tmp/pip-xKUWP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:23:40 INFO - Running setup.py (path:/tmp/pip-pgL3a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:23:40 INFO - Running setup.py (path:/tmp/pip-Gw05gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:23:40 INFO - Running setup.py (path:/tmp/pip-t72l88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:23:40 INFO - Running setup.py (path:/tmp/pip-mRi2CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:23:40 INFO - Running setup.py (path:/tmp/pip-aSy039-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:23:40 INFO - Running setup.py (path:/tmp/pip-LyMyyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:23:40 INFO - Running setup.py (path:/tmp/pip-rB2pU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:23:40 INFO - Running setup.py (path:/tmp/pip-9NtdFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:23:40 INFO - Running setup.py (path:/tmp/pip-zr3X1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:23:40 INFO - Running setup.py (path:/tmp/pip-oNpMgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:23:40 INFO - Running setup.py (path:/tmp/pip-va89rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:23:40 INFO - Running setup.py (path:/tmp/pip-Ovb63r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:23:40 INFO - Running setup.py (path:/tmp/pip-BOm1g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:41 INFO - Running setup.py (path:/tmp/pip-GPe8Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:23:41 INFO - Running setup.py (path:/tmp/pip-Sr3k00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:23:41 INFO - Running setup.py (path:/tmp/pip-z693k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:23:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:43 INFO - Downloading blessings-1.6.tar.gz 07:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:23:43 INFO - Installing collected packages: blessings 07:23:43 INFO - Running setup.py install for blessings 07:23:43 INFO - Successfully installed blessings 07:23:43 INFO - Cleaning up... 07:23:43 INFO - Return code: 0 07:23:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:23:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:23:43 INFO - Reading from file tmpfile_stdout 07:23:43 INFO - Current package versions: 07:23:43 INFO - argparse == 1.2.1 07:23:43 INFO - blessings == 1.6 07:23:43 INFO - blobuploader == 1.2.4 07:23:43 INFO - docopt == 0.6.1 07:23:43 INFO - functools32 == 3.2.3-2 07:23:43 INFO - jsonschema == 2.5.1 07:23:43 INFO - manifestparser == 1.1 07:23:43 INFO - mozInstall == 1.12 07:23:43 INFO - mozcrash == 1.0 07:23:43 INFO - mozdebug == 0.1 07:23:43 INFO - mozdevice == 0.49 07:23:43 INFO - mozfile == 1.2 07:23:43 INFO - mozhttpd == 0.7 07:23:43 INFO - mozinfo == 0.9 07:23:43 INFO - mozleak == 0.1 07:23:43 INFO - mozlog == 3.4 07:23:43 INFO - moznetwork == 0.27 07:23:43 INFO - mozprocess == 0.23 07:23:43 INFO - mozprofile == 0.28 07:23:43 INFO - mozrunner == 6.13 07:23:43 INFO - mozscreenshot == 0.1 07:23:43 INFO - mozsystemmonitor == 0.3 07:23:43 INFO - moztest == 0.7 07:23:43 INFO - mozversion == 1.4 07:23:43 INFO - psutil == 3.1.1 07:23:43 INFO - requests == 1.2.3 07:23:43 INFO - wsgiref == 0.1.2 07:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:43 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 0x7ff401273e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:23:43 INFO - Using env: {'DISPLAY': ':0', 07:23:43 INFO - 'HOME': '/home/cltbld', 07:23:43 INFO - 'LANG': 'en_US.UTF-8', 07:23:43 INFO - 'LANGUAGE': 'en_US:en', 07:23:43 INFO - 'LOGNAME': 'cltbld', 07:23:43 INFO - 'MAIL': '/var/mail/cltbld', 07:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:43 INFO - 'MOZ_NO_REMOTE': '1', 07:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:43 INFO - 'NO_EM_RESTART': '1', 07:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:43 INFO - 'PWD': '/builds/slave/test', 07:23:43 INFO - 'SHELL': '/bin/bash', 07:23:43 INFO - 'SHLVL': '1', 07:23:43 INFO - 'TERM': 'linux', 07:23:43 INFO - 'TMOUT': '86400', 07:23:43 INFO - 'USER': 'cltbld', 07:23:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:43 INFO - '_': '/tools/buildbot/bin/python'} 07:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:23:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:23:43 INFO - Cleaning up... 07:23:43 INFO - Return code: 0 07:23:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401273e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:23:43 INFO - Using env: {'DISPLAY': ':0', 07:23:43 INFO - 'HOME': '/home/cltbld', 07:23:43 INFO - 'LANG': 'en_US.UTF-8', 07:23:43 INFO - 'LANGUAGE': 'en_US:en', 07:23:43 INFO - 'LOGNAME': 'cltbld', 07:23:43 INFO - 'MAIL': '/var/mail/cltbld', 07:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:43 INFO - 'MOZ_NO_REMOTE': '1', 07:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:43 INFO - 'NO_EM_RESTART': '1', 07:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:43 INFO - 'PWD': '/builds/slave/test', 07:23:43 INFO - 'SHELL': '/bin/bash', 07:23:43 INFO - 'SHLVL': '1', 07:23:43 INFO - 'TERM': 'linux', 07:23:43 INFO - 'TMOUT': '86400', 07:23:43 INFO - 'USER': 'cltbld', 07:23:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:43 INFO - '_': '/tools/buildbot/bin/python'} 07:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:23:44 INFO - Cleaning up... 07:23:44 INFO - Return code: 0 07:23:44 INFO - Running post-action listener: _resource_record_post_action 07:23:44 INFO - Running post-action listener: _start_resource_monitoring 07:23:44 INFO - Starting resource monitoring. 07:23:44 INFO - [mozharness: 2016-12-03 15:23:44.168129Z] Finished create-virtualenv step (success) 07:23:44 INFO - [mozharness: 2016-12-03 15:23:44.168652Z] Running install step. 07:23:44 INFO - Running pre-action listener: _resource_record_pre_action 07:23:44 INFO - Running main action method: install 07:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:23:44 INFO - Reading from file tmpfile_stdout 07:23:44 INFO - Detecting whether we're running mozinstall >=1.0... 07:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:23:44 INFO - Reading from file tmpfile_stdout 07:23:44 INFO - Output received: 07:23:44 INFO - Usage: mozinstall [options] installer 07:23:44 INFO - Options: 07:23:44 INFO - -h, --help show this help message and exit 07:23:44 INFO - -d DEST, --destination=DEST 07:23:44 INFO - Directory to install application into. [default: 07:23:44 INFO - "/builds/slave/test"] 07:23:44 INFO - --app=APP Application being installed. [default: firefox] 07:23:44 INFO - mkdir: /builds/slave/test/build/application 07:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:24:00 INFO - Reading from file tmpfile_stdout 07:24:00 INFO - Output received: 07:24:00 INFO - /builds/slave/test/build/application/firefox/firefox 07:24:00 INFO - Running post-action listener: _resource_record_post_action 07:24:00 INFO - [mozharness: 2016-12-03 15:24:00.513727Z] Finished install step (success) 07:24:00 INFO - [mozharness: 2016-12-03 15:24:00.513970Z] Running run-tests step. 07:24:00 INFO - Running pre-action listener: _resource_record_pre_action 07:24:00 INFO - Running main action method: run_tests 07:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:24:00 INFO - Python 2.7.3 07:24:00 INFO - Return code: 0 07:24:00 INFO - grabbing minidump binary from tooltool 07:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:00 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 0xee7f20>, '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 0xe54c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe54f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:24:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:24:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:24:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:24:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:24:00 INFO - Return code: 0 07:24:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:24:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:24:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:24:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:24:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:24:00 INFO - Using env: {'DISPLAY': ':0', 07:24:00 INFO - 'HOME': '/home/cltbld', 07:24:00 INFO - 'LANG': 'en_US.UTF-8', 07:24:00 INFO - 'LANGUAGE': 'en_US:en', 07:24:00 INFO - 'LOGNAME': 'cltbld', 07:24:00 INFO - 'MAIL': '/var/mail/cltbld', 07:24:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:24:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:00 INFO - 'MOZ_NO_REMOTE': '1', 07:24:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:00 INFO - 'NO_EM_RESTART': '1', 07:24:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:00 INFO - 'PWD': '/builds/slave/test', 07:24:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:24:00 INFO - 'SHELL': '/bin/bash', 07:24:00 INFO - 'SHLVL': '1', 07:24:00 INFO - 'TERM': 'linux', 07:24:00 INFO - 'TMOUT': '86400', 07:24:00 INFO - 'USER': 'cltbld', 07:24:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490', 07:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:00 INFO - '_': '/tools/buildbot/bin/python'} 07:24:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:24:00 INFO - mozversion application_buildid: 20161203062943 07:24:00 INFO - mozversion application_changeset: f664a80393daca803f15055ade0c85145883f3ff 07:24:00 INFO - mozversion application_display_name: Nightly 07:24:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:24:00 INFO - mozversion application_name: Firefox 07:24:00 INFO - mozversion application_remotingname: firefox 07:24:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:24:00 INFO - mozversion application_vendor: Mozilla 07:24:00 INFO - mozversion application_version: 53.0a1 07:24:00 INFO - mozversion platform_buildid: 20161203062943 07:24:00 INFO - mozversion platform_changeset: f664a80393daca803f15055ade0c85145883f3ff 07:24:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:24:00 INFO - mozversion platform_version: 53.0a1 07:24:00 INFO - using testdate: 1480778640 07:24:00 INFO - actual date: 1480778640 07:24:00 INFO - starting webserver on 'localhost:59561' 07:24:00 INFO - SUITE-START | Running 2 tests 07:24:00 INFO - TEST-START | dromaeo_css 07:24:00 INFO - operating with platform_type : linux_ 07:24:00 INFO - Initialising browser for dromaeo_css test... 07:24:00 INFO - TEST-INFO | started process 27336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4h8TyU/profile http://localhost:59561/getInfo.html) 07:24:04 INFO - PROCESS | 27336 | __metrics Screen width/height:1600/1200 07:24:04 INFO - PROCESS | 27336 | colorDepth:24 07:24:04 INFO - PROCESS | 27336 | Browser inner width/height: 1024/697 07:24:04 INFO - PROCESS | 27336 | __metrics 07:24:05 INFO - PROCESS | 27336 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:24:05 INFO - PROCESS | 27336 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:24:06 INFO - TEST-INFO | 27336: exit 0 07:24:06 INFO - Browser initialized. 07:24:06 INFO - Running cycle 1/1 for dromaeo_css test... 07:24:06 INFO - TEST-INFO | started process 27420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4h8TyU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:24:18 INFO - PROCESS | 27420 | RSS: Main: 173993984 07:24:18 INFO - PROCESS | 27420 | 07:25:10 INFO - PROCESS | 27420 | 1480778710065 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:27:24 INFO - PROCESS | 27420 | Cycle 1(1): loaded http://localhost:59561/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59561/tests/dromaeo/cssquery-ext.html) 07:27:25 INFO - PROCESS | 27420 | RSS: Main: 316022784 07:27:25 INFO - PROCESS | 27420 | 07:30:28 INFO - PROCESS | 27420 | Cycle 1(1): loaded http://localhost:59561/tests/dromaeo/cssquery-ext.html (next: http://localhost:59561/tests/dromaeo/cssquery-jquery.html) 07:30:28 INFO - PROCESS | 27420 | RSS: Main: 275509248 07:30:28 INFO - PROCESS | 27420 | 07:33:31 INFO - PROCESS | 27420 | Cycle 1(1): loaded http://localhost:59561/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59561/tests/dromaeo/cssquery-mootools.html) 07:33:31 INFO - PROCESS | 27420 | RSS: Main: 220557312 07:33:31 INFO - PROCESS | 27420 | 07:36:34 INFO - PROCESS | 27420 | Cycle 1(1): loaded http://localhost:59561/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59561/tests/dromaeo/cssquery-prototype.html) 07:36:34 INFO - PROCESS | 27420 | RSS: Main: 247922688 07:36:34 INFO - PROCESS | 27420 | 07:39:38 INFO - PROCESS | 27420 | Cycle 1(1): loaded http://localhost:59561/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59561/tests/dromaeo/cssquery-yui.html) 07:39:38 INFO - PROCESS | 27420 | RSS: Main: 224014336 07:39:38 INFO - PROCESS | 27420 | 07:42:41 INFO - PROCESS | 27420 | Cycle 1(1): loaded http://localhost:59561/tests/dromaeo/cssquery-yui.html (next: http://localhost:59561/tests/dromaeo/cssquery-dojo.html) 07:42:42 INFO - PROCESS | 27420 | RSS: Main: 316416000 07:42:42 INFO - PROCESS | 27420 | 07:42:42 INFO - PROCESS | 27420 | __start_tp_report 07:42:42 INFO - PROCESS | 27420 | _x_x_mozilla_page_load 07:42:42 INFO - PROCESS | 27420 | _x_x_mozilla_page_load_details 07:42:42 INFO - PROCESS | 27420 | |i|pagename|runs| 07:42:42 INFO - PROCESS | 27420 | |0;dojo.html;2564.064116597442;2575.3947822261775;2611.1644273832376;2619.947601047979;2626.606009098634;4424.845130420436;4455.086707225019;4607.815687372506;4610.67725259232;4635.559621835924;4495.3257011448295;4585.128825523148;4604.263317869141;4651.9302210466785;4682.953170468286;4193.140406216734;4213.894652633693;4251.4685664291965;4276.593723596269;4360.694751367406;4214.136102099063;4291.549387314334;4296.699231053827;4324.675649326297;4362.1275744851155;4187.036981494243;4224.619784219435;4262.722923009995;4312.417823593806;4350.8912277193;4238.957610423918;4257.8296868125235;4260.9147817043795;4275.828966841323;4325.199838029975;4230.619244267999;4234.767087810169;4235.830566777326;4240.257954857888;4270.188664153832;4601.585857272828;4635.976820115911;4643.489216186251;4665.46347170073;4687.99208170245;4782.952170478286;4826.0347930414055;4833.444153922309;4884.389451318585;4907.4356449008465;4958.404991401055;4961.950380496221;4970.826021089245;4998.600111991032;5004.799808007675;4628.467726211461;4632.791524381411;4633.096546173531;4635.976820115945;4669.486356500782;4881.511848815161;4905.509449055137;4907.607391408679;5058.317127187856;5107.565856902131;4841.080194762983;4863.927041094315;4878.9512104878495;4905.5094490550655;4908.460069392364;4928.408590969107;4939.135651261086;4940.604751619861;4941.357623508921;4987.152184128707;4905.411350637946;4920.704757714549;4932.186189278729;4953.356063711694;4973.577245934136;4784;4830.758462076952;4832.057748738962;4837.95162048382;4856.441509226484;4142.565030671736;4153.460050193456;4157.563455837094;4164.958350416457;4192.434021407132;3635.5273814404486;3639.9636003640153;3644.052546337918;3665.193657395369;3672.632736726306;4181.393697913785;4211.957880421218;4276.914461710749;4279.935800962988;4309.116631090619;4865.513448655106;4892.437369702458;4906.58294045003;4914.189158788759;4915.16442204826;4259.8083086261195;4261.10516791471;4263.296556068214;4264.552222016706;4266.722663026893;4420.049689316748;4422.933655995163;4424.977875110604;4425.6238219751685;4426.336049592523;4643.349931009661;4646.907061858811;4650.4186976627925;4651.279051746985;4651.720896746206;4938.851834444972;4962.851114466572;4964.3298154748645;4966.130927087817;4968.0312339093525;4630.699004564693;4638.095571363552;4673.275642275453;4682.016776476978;4741.431028276491;4904.068227036852;4906.656534042583;4908.337374454403;4909.1899836528;4958.107540642719;4956.3804524434445;4972.378452693413;4976.30331753562;4992.775325110306;5017.498250174954;4730.101280756645;4774.95225047745;4777.784999675093;4831.444383895897;4832.420109586872;4781.665283430127;4815.3258543804595;4824.56578907886;4827.203511420576;4828.4688684244;4762.095201911626;4769.689970151929;4776.355192049168;4803.279508073817;4830.7826147824135;4888.608911287018;4905.48492408292;4907.092187945242;4912.606991440748;4944.876378090433;4683.555062269079;4723.574878260973;4742.952570474389;4771.809127634856;4780.760961951958 07:42:42 INFO - PROCESS | 27420 | |1;ext.html;550.1390324142716;564.8841987392585;567.4807551090752;571.0463525911726;572.5705720709468;27849;30819.537706934385;37974.81012594936;38708.61291387085;39081.80459097701;38888.22223555527;39234.41148382777;39282.41076383857;39362;39482.40776388349;7522.736704215367;7669.463137580372;7670.846583068335;7672.194419585947;7684.53892766433;7284.745033923814;7488.775336739906;9514.286428517855;9757.024297570257;9763.121319081281;9798.902010979906;9889.75275618108;9896.208303335716;9898.158656514204;9899.604015839357;9607;9683;9685.757856053584;9692.079252471003;9693.612255509772;9673.419594824332;9816.803663926752;9828.361156524803;9830.164436022947;9831.606735730562;35599.4660080099;36042.279154417025;36052.278954421025;36061.45907811385;36061.63938360609;3044.269375349922;3139.4505961456653;3148.244421338862;3245.107595411257;3291.358185153872;27951.30121746952;28076;28135.296617584725;28434.573481397794;28627.713722862714;3390.932181356384;3425.6745609167087;3455.3434847379167;3472.305538892206;3508.5088087667746;246750;246993;247707.9999999982;247916;248367;49381.75309123431;49660.751696241285;49674.75162624164;49862.75068624706;49972.25041624378;51862;52084;52107;52113.47886521162;52128;12934.935325323502;13513.66215844592;13551.25468099264;13552.119112257671;13556.186628802303;8505.914940850636;8898.06570310121;9567.378120422289;9706.417614943126;9715.902840971641;13582.660433489242;13692.65768355799;13696.383662735201;15001.924990374979;15454.150021748912;5760.671378974515;5790.971045144832;5917.852053698606;6000.3999600040515;6011.7595296187665;749.5315427857589;783.4515838912783;822.1490757066528;897.210454799772;938.2869019545195;25634.743652563237;26772.866135669585;27180.86409567979;27257.86371068132;27398.260173982842;914.6250037484599;914.7072936660338;921.7050543825911;999.9050090241416;1025.2771795883884;13693.452261909611;14343.85656143446;14692.902445485217;14755.188464634333;14863.33115009827;112506.43746781377;113143;113853.43073284581;113897.4305128469;114020;46697.76651116791;46744.766276168404;46759.53240467552;46820;46833;1131.3890499130378;1136.5169802833764;1147.0250287255933;1157.976840463203;1163.0637336943842;24925.626115607916;26026;26643.770348606307;27075.458490830468;27182.184534464;40145.1970960585;40428.393574097;40484.79757601193;40512.59487405206;40523.39214911838;321146;322667;322899;322905;323341;34010.65989340075;34222.48666269958;34692.826535867156;34867.65132348644;35084.824575876955;38806.61193388143;39092.413613795245;39706.2058758829;39893.800530997156;39983.60016399799;34159.14602134967;34193;34196.65803341935;34319.485207722406;34554;33774.83112584421;33958.49062264019;33977.49033764446;34146.48780268348;34744.47883281804;33762.83118584391;34068;34247.143821404665;34268.48597271093;34669;29775.553366699085;30726.84636576892;30902.84548577243;31291.374172516877;31312.843435782674;23547.41131471727;23595.29214123579;23772.881135594213;24110.638340424557;24210.87894560516 07:42:42 INFO - PROCESS | 27420 | |2;jquery.html;332.6440708441968;342.1053943936607;353.7223279725415;358.95692516897975;378.39456869009587;12457.128001039931;15767.448139315125;15966.28151733172;16247.431339903105;17328.480145595622;16304.83695163051;16613.50159495214;16766.58083547912;16875.324987000506;16885.071321077336;3875.3411919973673;4809.90380192396;4988.32657591226;5019.723915184663;5035.420926593433;4967.403911530621;4997.850064498053;5035.84892453227;5042.420121685998;5045.596352291808;4822.132016237076;4907.067657145149;4952.876178095558;5008.073506401309;5017.172166592508;4915.188993816016;4973.626977976648;4976.800927962895;4979.7261150636705;4984.651074424792;4475.7985890635;4480.588614586395;4482.372467854503;4619.491855895849;4870.829520966749;11960.102992275613;12166.5741699041;12174.208676436092;12176.269423834598;13076;1749.912504374776;1797.0834874214115;1922.6731455652432;1959.7623266965506;1996.620642078015;8631.654733810703;8725.301975841918;8986.730398088068;9143.862842057308;9272.814543709088;1606.7107920574292;1672.9498115056567;1702.6254224070685;1720.0711615727491;1725.7929048514134;66894;68308.6584567074;69934;71079.64460177666;71132;9707.90292097084;9762.90237097634;9780.657676981271;10131.746706332253;10140.847887281696;13419.93290033563;13442.46230150783;13455.394507247198;13458.192508449525;13465.326733663278;6699.430548403343;6947.305269473113;6954.582725036413;7199.676014579357;7201.495895287384;6468.514861385415;6472.288048314682;6529.54293199481;6549.6070235786;6755.121834161626;4108.281050816096;4127.711060225755;4235;4257.63810076147;4385.649148068147;1753.2022929567017;1780.4658602419222;1788.0880750817178;1788.2578729827237;1818.1545581304756;717.3938022371088;788.8777239527882;794.0630056533346;819.2708489444399;830.543201239316;15618.297176627078;16343.34626614946;16591.751123733153;17005.149742512825;17215;782.4131901074194;782.7847341981001;796.446469703562;805.7663277649533;860.9096044915319;8829.911700882909;9392.248620110511;9415.293852960918;9439.480828554495;9569.138777509917;316235;368420;377294.9516562884;377924;380505;46344.76827615908;61000.389996100355;76999.61500192463;77229.61385193038;77967.61016194883;848;876.0669886570909;877.4779006491127;878.7319867440492;883.4610887358706;14942.672295356157;15356.692866142392;15805.972611780198;15868.52394428169;16113.597160071093;34739.13152171115;35170.64829351674;35886.461703074994;36136;40001;50577.24134138064;50609.746951265006;51052.23421648604;51724.48275517347;52697;6795.38841504267;7140.500164988401;7190;7226.74706385274;7586.962065189638;10560.207984401048;12047.638570842888;12149.392530373269;12222.449989750305;12779.041571882331;9567;9922.603095876084;10224.591016359262;10270.691879243635;10711.036006759117;9278.164965153168;10024.298299119284;10254;10405.895941040493;10438.21713371485;10024.749381265527;10099.646512372032;10339.431331276852;10508.369497830156;10689.786204276026;7507.249275072449;7578.280063393969;7786.571738554434;7951.522908625501;7979.281864632211;7706.7687969361;9898.208143348658;10321.74195645115;10558.947205263925;10987.61543345979 07:42:42 INFO - PROCESS | 27420 | |3;mootools.html;1289.8194252804606;1352.8647135286471;1382.9446822127115;1598.650826518445;1614.7174244507207;6118.541109416789;6309.085182648513;6619.205695316563;7032.472564557659;7035.155781306244;6581.506387020981;6800.149981252343;6811.659417029141;6968.6864091115895;6970.268121847209;1997.1611922992379;2027.3107143571183;2029.3100345882397;2030.9390718278476;2032.0246281784678;1847.168774051682;1911.4170178095744;2037.052770461735;2053.1787285085934;2063.4634994901357;1831.6611426886002;1878.1548303263519;1879.7274395212687;1985.067018501302;2046.94882627934;2054.311805545144;2055.0649454498166;2056.8765874047604;2058.5471196336857;2061.721667574888;2042.1218875883364;2066.617675729995;2073.232903825579;2074.8651337663155;2075.95848083039;6915.861682766367;7096.609686467243;7111.7866464006165;7114.430845532345;7119.715211391538;4285.678574106923;4406.7355958642265;4412.492563355223;4426.15902978433;4433.534478879704;2608.5304645163865;2814.127620437671;2814.451182019507;2831.631887854566;2861.241770930705;832.3798769916391;847.4110493207223;850.961706723199;851.9190676885686;881.5239770523909;8879.422837515542;9088.136627020422;9124.908750912473;9394.953025234898;9440.433573985514;3757.28611563802;3854.20988697322;3935.330993731073;3942.6057394260342;3964.861229856941;7080.893786593205;7120.216776154619;7126.180489243803;7133.785986420416;7144.178419481722;4378.496472905656;4382.496012958551;4385.473743150842;4387.648988080946;4388.27593447084;3938.3107956107565;4093.263212621697;4099.672026237894;4102.220578090153;4102.50769907607;3087.9073627791204;3108.968910310868;3169.762267829922;3224.290656055664;3228.1606782236786;978.1587834462357;978.5351957819978;985.571276494727;986.2110311750571;994.3437331361267;708.7200555780438;709.2729951799447;743.9956059319983;744.0661969228584;753.3257734327746;4773.856784296477;4957.256411538298;5130.691673623202;5133.614978876599;5237.764300606482;764.4037650632515;766.5400759544228;791.6041979010495;797.1669605262515;848.749618862437;3332.600087989457;3397.813120278359;3415.692587667122;3452.4993875887853;3469.5663042119736;8187.4268801184535;8296.211859873303;8477.237048665527;8477.74566762998;8482.151784821468;8058.758237252891;8279.54462504568;8288.088310285864;8306.210909963544;8326.876646455115;6322.1981735205245;6602;6610.933890661128;6614.371634694697;6615.338466153443;4916.70499770015;4997.825076122318;5088.771005304844;5144.794208231779;5296.894062118659;7668.348190403655;7772.68909243624;7896.565688887166;8020.478668886503;8058.194180581895;7766.417518686234;7866.685332586632;7870.606469676608;7912.248336408032;7918.208179182036;6106.084087386927;6198.039303907902;6208.037754148114;6226.377362263918;6228.252609686867;6657.034729964225;6671.232808226922;6692;6730.495212859153;6753.527253092237;6095.817125486243;6119.755209791559;6132.386761323832;6198.504119670325;6231.937680623136;5969.791057312973;6021.789237376671;6133.202683651097;6200.968995154995;6290.21372328459;5770.365259821332;5797.681127537857;5812.070068789142;5817.069268916953;5829.883402331845;4194.4337514435165;4269.487661480518;4292.270314046557;4394.736315821061;4480.663950203813;4183.184279065553;4273.686612852758;4341.110072435206;4420.690551661352;4533.977330113328 07:42:42 INFO - PROCESS | 27420 | |4;prototype.html;275.79453307286076;295.3914935233421;300.46067309180023;303.24038284098333;303.6629341431012;4580.748058856761;4730.787114579844;4804.189549113773;4813.133635945528;4821.577634597793;4652.255639097745;4748.002919386933;4769.8807529811775;4780.282957556368;4788.281757736341;3753.099256178511;3761.605031471697;3769.151940813316;3779.7354185207046;3792.8482860685676;3561.5904171020406;3651.543557055368;3660.7071434285326;3759.3045286622064;3773.735718603402;3700.7964561949084;3703.925921481569;3727.589965103836;3732.4961130247475;3736.2252929858237;3735.14091758897;3737.6075512071384;3741.2143449875557;3756.3050835595504;3781.8865434037025;3343.8996830095134;3358.7480938929434;3359.5800524934384;3361.5798025246845;3377.273886114497;4460.531644177379;4644.489106198315;4672.5327467253;4685.929711054337;4750.857474275777;4228.76741779202;4236.9364459533135;4258.084511829971;4278.828846846122;4280.443542339476;4941.7034977901085;4966.453690094087;4971.428285747149;4988.301637770715;4991.675541089818;3488.825558722079;3571.8035508047046;3573.5711714594154;3591.712662986955;3601.225736466646;5138.486151384869;5157.200633901752;5158.638895277332;5212.1921102228835;5221.968626236627;3786.583475817658;3789.5452545694693;3795.221979494197;3811.447340135665;3813.7773581323736;3854.8843534694006;3859.0931131184147;3865.613438656112;3867.419887016914;3874.5737968823405;4046.107033471082;4244.617984381421;4248.91502169961;4254.957450425518;4254.957705240768;4946.455889852114;4951.207806750903;4966.180580204225;4967.950320496821;4973.925391119136;1249.1505776072177;1273.688101255708;1281.3080936294482;1282.2178471132602;1284.8907842833278;891.38494438837;903.3676426501344;904.4076130134772;916.8303863785088;917.1195652173855;4264.637505812041;4277.550857160016;4285.764282964405;4308.612224899774;4320.956790432118;4940.431850337257;4951.801927922843;4952.752362381866;4961.50384961501;5025.271335656309;4267.829286828554;4270.466191726035;4285.700000999963;4292.291771857671;4308.655307575386;2517.8111641626583;2643.2863126956;2644.8942042318477;2657.8006649500976;2660.348214687414;4717.551832575969;4717.867711749155;4741.620670346433;4741.881452963704;4763.1426343258545;4854.320395144682;5123.769430375642;5124.769385377667;5128.512791284897;5135.563477104413;4681.812727490862;4704.741239231738;4705.482396936334;4705.847067468424;4714.6464015199;4991.625628077836;4998.475160108282;5000.699958002531;5000.749962501933;5020.49795020495;4829.492903245108;4921.212605983169;4921.876953076202;4952.826651067196;4966.900661986668;4795.256735206049;4855.5676075557085;4866.8053277868485;4869.415670119608;4875.609951203966;3597.028802223437;3598.694111000594;3626.437902125175;3635.8909232723063;3650.9634903651686;5049.400652018689;5090.516400941905;5100.591952643706;5186.481351864783;5207;4955.108080545537;4967.3045773591;4970.155073637418;4972.229304457815;4973.303737476828;4976.353074100344;4979.427365852828;4996.650234483552;5001.549860512571;5017.37282839645;4713.646476514206;4849.957259189291;4865.854024379274;4873.220284754422;4909.846186146324;5007.873228523698;5018.749062546931;5023.648344615988;5024.84925452237;5030.320906677552;4902.803887844446;4907.97546012282;4916.483769204325;4928.507149285043;4938.777755000961 07:42:42 INFO - PROCESS | 27420 | |5;yui.html;663.5288944849154;671.5198632977421;689.3554526517706;714.4855703893198;723.9022731931187;12380.81428778569;13383.73232535351;13409.999999999987;13429.32853357333;13439.59681209564;12781.808272875915;12916.612501624966;12983.480660773557;12995.610131696065;13025.544105956293;602.1209034809184;619.5446346934999;732.8351120997772;746.0599644447981;748.6256871564218;725.8838585826269;745.757628770649;755.2673906310897;755.9924400756005;756.670848181043;792.7344339646226;798.1340245833278;800.0399520575304;801.9975031210986;802.2859654907137;626.6709977261928;645.1000853808957;788.6924099601132;797.178905727102;797.5453991225004;558.1293182635062;573.6672729816696;577.1112486770369;577.9248697669318;578.9305283366023;12488.687782805502;12533.248005119722;12541.122121451503;12545.498180072786;12550.560730374484;12305.200161989442;12364.44360003802;12797.936010319889;12876.742465150739;13125.540606078837;9260.722178334661;9306.488143152124;9790.5594248259;9808.705738827846;9855.753606159831;4047.8988025299604;4069.267531844267;4077.1234184650443;4096.959030409687;4127.360259159805;62587.37412625906;64244.35755642477;66164.6691766543;66688.3331166687;67437.6628116866;10017.749556261006;10192.592296308212;10195.541200645841;10280.948595256976;10392.22058345612;16693.415730449375;16833.83166168347;17078.146092695315;17591.120443978005;17613.20740566652;6411.455026322721;6421.1230277661;6556.27880933097;6569.9343006569325;6601.141851559362;3578.2306804037257;3592.928141437209;3641.927161456756;3663.19409729859;3702.1670124222373;2871.1386584025126;2966.985165074204;2969;2975.0925967580097;3005.54916762483;506.2861365474737;509.5032343465092;512.2802462540062;520.7396301849076;527.5120513524975;592.5541678304922;599.1791245993018;601.7695599932395;608.5983251054283;618.7524990004034;7502.549847009197;7659.885101723478;7726.141327708784;8016.630936139818;8072.273495385443;482.4692837878376;544.4555444555444;564.4750382144645;579.0705917003233;580.7241560258927;3737.981310093432;3875.1668391296007;3926.371780515104;4015.417764424142;4111.321631930758;70383.64808175927;71642.64178679073;73528;74158.6292068547;74393;52394.73802630963;55949.44050559442;62986;64391.67804161043;64462.6776866122;57613.711931440914;58413.70793146092;59166.112508312406;59808.70095649494;60012.69993650004;7592.535271739603;7848;7996;8116.837663246584;8139.83720325602;40788.79605601953;40910;41452;41604.79197603992;42308.788456057526;52001.7399912998;54899.72550137224;55060.72469637626;55605;56430.43569564252;9472.384295020802;9568.808623827623;9634.13292803651;9839.311248212844;9996.950015250168;11081.445927703744;11350.318980861175;11368.886311136783;11415.543378264776;11830.231034982698;10344.120749736056;10448.373097614167;10571.524281407508;10578.206634502289;11275.097992160772;10148.847767283645;10322.277440579088;10464.895351046393;10519.474026298807;10956.835647465454;10368.896311036793;10488;10536.315139515908;10939.45302734876;11044.723881903017;8085.959570202347;8157.143499932659;8470.534120623424;8531.53076580794;8708.433951793113;7548.698052078075;7555.13115991668;7570.205128461653;7710.190430004769;7870.331021863206 07:42:42 INFO - PROCESS | 27420 | __end_tp_report 07:42:42 INFO - PROCESS | 27420 | __start_cc_report 07:42:42 INFO - PROCESS | 27420 | _x_x_mozilla_cycle_collect,1411 07:42:42 INFO - PROCESS | 27420 | __end_cc_report 07:42:42 INFO - PROCESS | 27420 | __startTimestamp1480779762021__endTimestamp 07:42:42 INFO - PROCESS | 27420 | 07:42:42 INFO - PROCESS | 27420 | ------- Summary: start ------- 07:42:42 INFO - PROCESS | 27420 | Number of tests: 6 07:42:42 INFO - PROCESS | 27420 | 07:42:42 INFO - PROCESS | 27420 | [#0] dojo.html Cycles:165 Average:4564.99 Median:4682.95 stddev:473.12 (10.1%) stddev-sans-first:447.78 07:42:42 INFO - PROCESS | 27420 | Values: 2564.1 2575.4 2611.2 2619.9 2626.6 4424.8 4455.1 4607.8 4610.7 4635.6 4495.3 4585.1 4604.3 4651.9 4683.0 4193.1 4213.9 4251.5 4276.6 4360.7 4214.1 4291.5 4296.7 4324.7 4362.1 4187.0 4224.6 4262.7 4312.4 4350.9 4239.0 4257.8 4260.9 4275.8 4325.2 4230.6 4234.8 4235.8 4240.3 4270.2 4601.6 4636.0 4643.5 4665.5 4688.0 4783.0 4826.0 4833.4 4884.4 4907.4 4958.4 4962.0 4970.8 4998.6 5004.8 4628.5 4632.8 4633.1 4636.0 4669.5 4881.5 4905.5 4907.6 5058.3 5107.6 4841.1 4863.9 4879.0 4905.5 4908.5 4928.4 4939.1 4940.6 4941.4 4987.2 4905.4 4920.7 4932.2 4953.4 4973.6 4784.0 4830.8 4832.1 4838.0 4856.4 4142.6 4153.5 4157.6 4165.0 4192.4 3635.5 3640.0 3644.1 3665.2 3672.6 4181.4 4212.0 4276.9 4279.9 4309.1 4865.5 4892.4 4906.6 4914.2 4915.2 4259.8 4261.1 4263.3 4264.6 4266.7 4420.0 4422.9 4425.0 4425.6 4426.3 4643.3 4646.9 4650.4 4651.3 4651.7 4938.9 4962.9 4964.3 4966.1 4968.0 4630.7 4638.1 4673.3 4682.0 4741.4 4904.1 4906.7 4908.3 4909.2 4958.1 4956.4 4972.4 4976.3 4992.8 5017.5 4730.1 4775.0 4777.8 4831.4 4832.4 4781.7 4815.3 4824.6 4827.2 4828.5 4762.1 4769.7 4776.4 4803.3 4830.8 4888.6 4905.5 4907.1 4912.6 4944.9 4683.6 4723.6 4743.0 4771.8 4780.8 07:42:42 INFO - PROCESS | 27420 | 07:42:42 INFO - PROCESS | 27420 | [#1] ext.html Cycles:180 Average:39130.78 Median:19188.08 stddev:64153.03 (334.3%) stddev-sans-first:64267.60 07:42:42 INFO - PROCESS | 27420 | Values: 550.1 564.9 567.5 571.0 572.6 27849.0 30819.5 37974.8 38708.6 39081.8 38888.2 39234.4 39282.4 39362.0 39482.4 7522.7 7669.5 7670.8 7672.2 7684.5 7284.7 7488.8 9514.3 9757.0 9763.1 9798.9 9889.8 9896.2 9898.2 9899.6 9607.0 9683.0 9685.8 9692.1 9693.6 9673.4 9816.8 9828.4 9830.2 9831.6 35599.5 36042.3 36052.3 36061.5 36061.6 3044.3 3139.5 3148.2 3245.1 3291.4 27951.3 28076.0 28135.3 28434.6 28627.7 3390.9 3425.7 3455.3 3472.3 3508.5 246750.0 246993.0 247708.0 247916.0 248367.0 49381.8 49660.8 49674.8 49862.8 49972.3 51862.0 52084.0 52107.0 52113.5 52128.0 12934.9 13513.7 13551.3 13552.1 13556.2 8505.9 8898.1 9567.4 9706.4 9715.9 13582.7 13692.7 13696.4 15001.9 15454.2 5760.7 5791.0 5917.9 6000.4 6011.8 749.5 783.5 822.1 897.2 938.3 25634.7 26772.9 27180.9 27257.9 27398.3 914.6 914.7 921.7 999.9 1025.3 13693.5 14343.9 14692.9 14755.2 14863.3 112506.4 113143.0 113853.4 113897.4 114020.0 46697.8 46744.8 46759.5 46820.0 46833.0 1131.4 1136.5 1147.0 1158.0 1163.1 24925.6 26026.0 26643.8 27075.5 27182.2 40145.2 40428.4 40484.8 40512.6 40523.4 321146.0 322667.0 322899.0 322905.0 323341.0 34010.7 34222.5 34692.8 34867.7 35084.8 38806.6 39092.4 39706.2 39893.8 39983.6 34159.1 34193.0 34196.7 34319.5 34554.0 33774.8 33958.5 33977.5 34146.5 34744.5 33762.8 34068.0 34247.1 34268.5 34669.0 29775.6 30726.8 30902.8 31291.4 31312.8 23547.4 23595.3 23772.9 24110.6 24210.9 07:42:42 INFO - PROCESS | 27420 | 07:42:42 INFO - PROCESS | 27420 | [#2] jquery.html Cycles:180 Average:22919.23 Median:4550.93 stddev:60337.75 (1325.8%) stddev-sans-first:60483.18 07:42:42 INFO - PROCESS | 27420 | Values: 332.6 342.1 353.7 359.0 378.4 12457.1 15767.4 15966.3 16247.4 17328.5 16304.8 16613.5 16766.6 16875.3 16885.1 3875.3 4809.9 4988.3 5019.7 5035.4 4967.4 4997.9 5035.8 5042.4 5045.6 4822.1 4907.1 4952.9 5008.1 5017.2 4915.2 4973.6 4976.8 4979.7 4984.7 4475.8 4480.6 4482.4 4619.5 4870.8 11960.1 12166.6 12174.2 12176.3 13076.0 1749.9 1797.1 1922.7 1959.8 1996.6 8631.7 8725.3 8986.7 9143.9 9272.8 1606.7 1672.9 1702.6 1720.1 1725.8 66894.0 68308.7 69934.0 71079.6 71132.0 9707.9 9762.9 9780.7 10131.7 10140.8 13419.9 13442.5 13455.4 13458.2 13465.3 6699.4 6947.3 6954.6 7199.7 7201.5 6468.5 6472.3 6529.5 6549.6 6755.1 4108.3 4127.7 4235.0 4257.6 4385.6 1753.2 1780.5 1788.1 1788.3 1818.2 717.4 788.9 794.1 819.3 830.5 15618.3 16343.3 16591.8 17005.1 17215.0 782.4 782.8 796.4 805.8 860.9 8829.9 9392.2 9415.3 9439.5 9569.1 316235.0 368420.0 377295.0 377924.0 380505.0 46344.8 61000.4 76999.6 77229.6 77967.6 848.0 876.1 877.5 878.7 883.5 14942.7 15356.7 15806.0 15868.5 16113.6 34739.1 35170.6 35886.5 36136.0 40001.0 50577.2 50609.7 51052.2 51724.5 52697.0 6795.4 7140.5 7190.0 7226.7 7587.0 10560.2 12047.6 12149.4 12222.4 12779.0 9567.0 9922.6 10224.6 10270.7 10711.0 9278.2 10024.3 10254.0 10405.9 10438.2 10024.7 10099.6 10339.4 10508.4 10689.8 7507.2 7578.3 7786.6 7951.5 7979.3 7706.8 9898.2 10321.7 10558.9 10987.6 07:42:42 INFO - PROCESS | 27420 | 07:42:42 INFO - PROCESS | 27420 | [#3] mootools.html Cycles:180 Average:4625.59 Median:5995.79 stddev:2463.42 (41.1%) stddev-sans-first:2457.57 07:42:42 INFO - PROCESS | 27420 | Values: 1289.8 1352.9 1382.9 1598.7 1614.7 6118.5 6309.1 6619.2 7032.5 7035.2 6581.5 6800.1 6811.7 6968.7 6970.3 1997.2 2027.3 2029.3 2030.9 2032.0 1847.2 1911.4 2037.1 2053.2 2063.5 1831.7 1878.2 1879.7 1985.1 2046.9 2054.3 2055.1 2056.9 2058.5 2061.7 2042.1 2066.6 2073.2 2074.9 2076.0 6915.9 7096.6 7111.8 7114.4 7119.7 4285.7 4406.7 4412.5 4426.2 4433.5 2608.5 2814.1 2814.5 2831.6 2861.2 832.4 847.4 851.0 851.9 881.5 8879.4 9088.1 9124.9 9395.0 9440.4 3757.3 3854.2 3935.3 3942.6 3964.9 7080.9 7120.2 7126.2 7133.8 7144.2 4378.5 4382.5 4385.5 4387.6 4388.3 3938.3 4093.3 4099.7 4102.2 4102.5 3087.9 3109.0 3169.8 3224.3 3228.2 978.2 978.5 985.6 986.2 994.3 708.7 709.3 744.0 744.1 753.3 4773.9 4957.3 5130.7 5133.6 5237.8 764.4 766.5 791.6 797.2 848.7 3332.6 3397.8 3415.7 3452.5 3469.6 8187.4 8296.2 8477.2 8477.7 8482.2 8058.8 8279.5 8288.1 8306.2 8326.9 6322.2 6602.0 6610.9 6614.4 6615.3 4916.7 4997.8 5088.8 5144.8 5296.9 7668.3 7772.7 7896.6 8020.5 8058.2 7766.4 7866.7 7870.6 7912.2 7918.2 6106.1 6198.0 6208.0 6226.4 6228.3 6657.0 6671.2 6692.0 6730.5 6753.5 6095.8 6119.8 6132.4 6198.5 6231.9 5969.8 6021.8 6133.2 6201.0 6290.2 5770.4 5797.7 5812.1 5817.1 5829.9 4194.4 4269.5 4292.3 4394.7 4480.7 4183.2 4273.7 4341.1 4420.7 4534.0 07:42:42 INFO - PROCESS | 27420 | 07:42:42 INFO - PROCESS | 27420 | [#4] prototype.html Cycles:180 Average:4129.26 Median:4714.15 stddev:1178.56 (25.0%) stddev-sans-first:1145.83 07:42:42 INFO - PROCESS | 27420 | Values: 275.8 295.4 300.5 303.2 303.7 4580.7 4730.8 4804.2 4813.1 4821.6 4652.3 4748.0 4769.9 4780.3 4788.3 3753.1 3761.6 3769.2 3779.7 3792.8 3561.6 3651.5 3660.7 3759.3 3773.7 3700.8 3703.9 3727.6 3732.5 3736.2 3735.1 3737.6 3741.2 3756.3 3781.9 3343.9 3358.7 3359.6 3361.6 3377.3 4460.5 4644.5 4672.5 4685.9 4750.9 4228.8 4236.9 4258.1 4278.8 4280.4 4941.7 4966.5 4971.4 4988.3 4991.7 3488.8 3571.8 3573.6 3591.7 3601.2 5138.5 5157.2 5158.6 5212.2 5222.0 3786.6 3789.5 3795.2 3811.4 3813.8 3854.9 3859.1 3865.6 3867.4 3874.6 4046.1 4244.6 4248.9 4255.0 4255.0 4946.5 4951.2 4966.2 4968.0 4973.9 1249.2 1273.7 1281.3 1282.2 1284.9 891.4 903.4 904.4 916.8 917.1 4264.6 4277.6 4285.8 4308.6 4321.0 4940.4 4951.8 4952.8 4961.5 5025.3 4267.8 4270.5 4285.7 4292.3 4308.7 2517.8 2643.3 2644.9 2657.8 2660.3 4717.6 4717.9 4741.6 4741.9 4763.1 4854.3 5123.8 5124.8 5128.5 5135.6 4681.8 4704.7 4705.5 4705.8 4714.6 4991.6 4998.5 5000.7 5000.7 5020.5 4829.5 4921.2 4921.9 4952.8 4966.9 4795.3 4855.6 4866.8 4869.4 4875.6 3597.0 3598.7 3626.4 3635.9 3651.0 5049.4 5090.5 5100.6 5186.5 5207.0 4955.1 4967.3 4970.2 4972.2 4973.3 4976.4 4979.4 4996.7 5001.5 5017.4 4713.6 4850.0 4865.9 4873.2 4909.8 5007.9 5018.7 5023.6 5024.8 5030.3 4902.8 4908.0 4916.5 4928.5 4938.8 07:42:42 INFO - PROCESS | 27420 | 07:42:42 INFO - PROCESS | 27420 | [#5] yui.html Cycles:180 Average:15376.93 Median:28502.05 stddev:20452.41 (71.8%) stddev-sans-first:20479.94 07:42:42 INFO - PROCESS | 27420 | Values: 663.5 671.5 689.4 714.5 723.9 12380.8 13383.7 13410.0 13429.3 13439.6 12781.8 12916.6 12983.5 12995.6 13025.5 602.1 619.5 732.8 746.1 748.6 725.9 745.8 755.3 756.0 756.7 792.7 798.1 800.0 802.0 802.3 626.7 645.1 788.7 797.2 797.5 558.1 573.7 577.1 577.9 578.9 12488.7 12533.2 12541.1 12545.5 12550.6 12305.2 12364.4 12797.9 12876.7 13125.5 9260.7 9306.5 9790.6 9808.7 9855.8 4047.9 4069.3 4077.1 4097.0 4127.4 62587.4 64244.4 66164.7 66688.3 67437.7 10017.7 10192.6 10195.5 10280.9 10392.2 16693.4 16833.8 17078.1 17591.1 17613.2 6411.5 6421.1 6556.3 6569.9 6601.1 3578.2 3592.9 3641.9 3663.2 3702.2 2871.1 2967.0 2969.0 2975.1 3005.5 506.3 509.5 512.3 520.7 527.5 592.6 599.2 601.8 608.6 618.8 7502.5 7659.9 7726.1 8016.6 8072.3 482.5 544.5 564.5 579.1 580.7 3738.0 3875.2 3926.4 4015.4 4111.3 70383.6 71642.6 73528.0 74158.6 74393.0 52394.7 55949.4 62986.0 64391.7 64462.7 57613.7 58413.7 59166.1 59808.7 60012.7 7592.5 7848.0 7996.0 8116.8 8139.8 40788.8 40910.0 41452.0 41604.8 42308.8 52001.7 54899.7 55060.7 55605.0 56430.4 9472.4 9568.8 9634.1 9839.3 9997.0 11081.4 11350.3 11368.9 11415.5 11830.2 10344.1 10448.4 10571.5 10578.2 11275.1 10148.8 10322.3 10464.9 10519.5 10956.8 10368.9 10488.0 10536.3 10939.5 11044.7 8086.0 8157.1 8470.5 8531.5 8708.4 7548.7 7555.1 7570.2 7710.2 7870.3 07:42:42 INFO - PROCESS | 27420 | -------- Summary: end -------- 07:42:42 INFO - PROCESS | 27420 | 07:42:42 INFO - TEST-INFO | 27420: exit 0 07:42:42 INFO - TEST-OK | dromaeo_css | took 1122203ms 07:42:42 INFO - TEST-START | kraken 07:42:42 INFO - operating with platform_type : linux_ 07:42:42 INFO - Initialising browser for kraken test... 07:42:42 INFO - TEST-INFO | started process 27763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HYBpi/profile http://localhost:59561/getInfo.html) 07:42:47 INFO - PROCESS | 27763 | __metrics Screen width/height:1600/1200 07:42:47 INFO - PROCESS | 27763 | colorDepth:24 07:42:47 INFO - PROCESS | 27763 | Browser inner width/height: 1024/697 07:42:47 INFO - PROCESS | 27763 | __metrics 07:42:47 INFO - PROCESS | 27763 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:42:47 INFO - PROCESS | 27763 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:42:48 INFO - PROCESS | 27763 | console.error: PushService: 07:42:48 INFO - PROCESS | 27763 | stateChangeProcessEnqueue: Error transitioning state 07:42:48 INFO - PROCESS | 27763 | UnknownError 07:42:48 INFO - TEST-INFO | 27763: exit 0 07:42:48 INFO - Browser initialized. 07:42:48 INFO - Running cycle 1/1 for kraken test... 07:42:48 INFO - TEST-INFO | started process 27845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HYBpi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:43:01 INFO - PROCESS | 27845 | RSS: Main: 173367296 07:43:01 INFO - PROCESS | 27845 | 07:43:04 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59561/tests/kraken/driver.html?testName=audio-beat-detection) 07:43:04 INFO - PROCESS | 27845 | RSS: Main: 239652864 07:43:04 INFO - PROCESS | 27845 | 07:43:07 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59561/tests/kraken/driver.html?testName=audio-dft) 07:43:08 INFO - PROCESS | 27845 | RSS: Main: 217952256 07:43:08 INFO - PROCESS | 27845 | 07:43:11 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59561/tests/kraken/driver.html?testName=audio-fft) 07:43:12 INFO - PROCESS | 27845 | RSS: Main: 300892160 07:43:12 INFO - PROCESS | 27845 | 07:43:14 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59561/tests/kraken/driver.html?testName=audio-oscillator) 07:43:14 INFO - PROCESS | 27845 | RSS: Main: 209559552 07:43:14 INFO - PROCESS | 27845 | 07:43:17 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59561/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:43:17 INFO - PROCESS | 27845 | RSS: Main: 214163456 07:43:17 INFO - PROCESS | 27845 | 07:43:20 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59561/tests/kraken/driver.html?testName=imaging-darkroom) 07:43:21 INFO - PROCESS | 27845 | RSS: Main: 254386176 07:43:21 INFO - PROCESS | 27845 | 07:43:25 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59561/tests/kraken/driver.html?testName=imaging-desaturate) 07:43:25 INFO - PROCESS | 27845 | RSS: Main: 248471552 07:43:25 INFO - PROCESS | 27845 | 07:43:28 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59561/tests/kraken/driver.html?testName=json-parse-financial) 07:43:29 INFO - PROCESS | 27845 | RSS: Main: 249831424 07:43:29 INFO - PROCESS | 27845 | 07:43:30 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59561/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:43:31 INFO - PROCESS | 27845 | RSS: Main: 213114880 07:43:31 INFO - PROCESS | 27845 | 07:43:33 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59561/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:43:34 INFO - PROCESS | 27845 | RSS: Main: 220971008 07:43:34 INFO - PROCESS | 27845 | 07:43:36 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59561/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:43:36 INFO - PROCESS | 27845 | RSS: Main: 229126144 07:43:36 INFO - PROCESS | 27845 | 07:43:39 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:43:40 INFO - PROCESS | 27845 | RSS: Main: 237854720 07:43:40 INFO - PROCESS | 27845 | 07:43:43 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:43:44 INFO - PROCESS | 27845 | RSS: Main: 234696704 07:43:44 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | Cycle 1(1): loaded http://localhost:59561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59561/tests/kraken/driver.html?testName=ai-astar) 07:43:46 INFO - PROCESS | 27845 | RSS: Main: 284467200 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | __start_tp_report 07:43:46 INFO - PROCESS | 27845 | _x_x_mozilla_page_load 07:43:46 INFO - PROCESS | 27845 | _x_x_mozilla_page_load_details 07:43:46 INFO - PROCESS | 27845 | |i|pagename|runs| 07:43:46 INFO - PROCESS | 27845 | |0;ai-astar;112;115;116;114;116;115;113;113;113;114 07:43:46 INFO - PROCESS | 27845 | |1;audio-beat-detection;153;130;127;166;132;133;128;132;160;130 07:43:46 INFO - PROCESS | 27845 | |2;audio-dft;164;163;165;164;163;163;161;162;162;161 07:43:46 INFO - PROCESS | 27845 | |3;audio-fft;78;78;76;115;78;76;78;76;94;77 07:43:46 INFO - PROCESS | 27845 | |4;audio-oscillator;84;84;108;83;83;83;104;84;83;112 07:43:46 INFO - PROCESS | 27845 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;119;119;118 07:43:46 INFO - PROCESS | 27845 | |6;imaging-darkroom;147;148;147;147;147;148;147;146;147;148 07:43:46 INFO - PROCESS | 27845 | |7;imaging-desaturate;95;95;96;96;96;96;95;96;95;95 07:43:46 INFO - PROCESS | 27845 | |8;json-parse-financial;68;64;65;66;65;66;66;66;66;66 07:43:46 INFO - PROCESS | 27845 | |9;json-stringify-tinderbox;66;65;66;66;67;65;66;66;71;67 07:43:46 INFO - PROCESS | 27845 | |10;stanford-crypto-aes;84;85;85;98;89;93;84;94;86;86 07:43:46 INFO - PROCESS | 27845 | |11;stanford-crypto-ccm;153;145;152;140;149;141;141;152;184;141 07:43:46 INFO - PROCESS | 27845 | |12;stanford-crypto-pbkdf2;185;182;179;182;181;181;179;184;181;180 07:43:46 INFO - PROCESS | 27845 | |13;stanford-crypto-sha256-iterative;71;71;72;75;71;75;70;70;70;74 07:43:46 INFO - PROCESS | 27845 | __end_tp_report 07:43:46 INFO - PROCESS | 27845 | __start_cc_report 07:43:46 INFO - PROCESS | 27845 | _x_x_mozilla_cycle_collect,1951 07:43:46 INFO - PROCESS | 27845 | __end_cc_report 07:43:46 INFO - PROCESS | 27845 | __startTimestamp1480779826286__endTimestamp 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | ------- Summary: start ------- 07:43:46 INFO - PROCESS | 27845 | Number of tests: 14 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:1.37 (1.2%) stddev-sans-first:1.22 07:43:46 INFO - PROCESS | 27845 | Values: 112.0 115.0 116.0 114.0 116.0 115.0 113.0 113.0 113.0 114.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:132.50 stddev:14.63 (11.0%) stddev-sans-first:14.63 07:43:46 INFO - PROCESS | 27845 | Values: 153.0 130.0 127.0 166.0 132.0 133.0 128.0 132.0 160.0 130.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.32 (0.8%) stddev-sans-first:1.32 07:43:46 INFO - PROCESS | 27845 | Values: 164.0 163.0 165.0 164.0 163.0 163.0 161.0 162.0 162.0 161.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#3] audio-fft Cycles:10 Average:82.60 Median:78.00 stddev:12.59 (16.1%) stddev-sans-first:13.24 07:43:46 INFO - PROCESS | 27845 | Values: 78.0 78.0 76.0 115.0 78.0 76.0 78.0 76.0 94.0 77.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:83.00 stddev:12.03 (14.5%) stddev-sans-first:12.50 07:43:46 INFO - PROCESS | 27845 | Values: 84.0 84.0 108.0 83.0 83.0 83.0 104.0 84.0 83.0 112.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:43:46 INFO - PROCESS | 27845 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 119.0 119.0 118.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:43:46 INFO - PROCESS | 27845 | Values: 147.0 148.0 147.0 147.0 147.0 148.0 147.0 146.0 147.0 148.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:43:46 INFO - PROCESS | 27845 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:0.73 07:43:46 INFO - PROCESS | 27845 | Values: 68.0 64.0 65.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:1.72 (2.6%) stddev-sans-first:1.81 07:43:46 INFO - PROCESS | 27845 | Values: 66.0 65.0 66.0 66.0 67.0 65.0 66.0 66.0 71.0 67.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:87.50 stddev:4.93 (5.6%) stddev-sans-first:4.96 07:43:46 INFO - PROCESS | 27845 | Values: 84.0 85.0 85.0 98.0 89.0 93.0 84.0 94.0 86.0 86.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:150.50 stddev:13.09 (8.7%) stddev-sans-first:13.83 07:43:46 INFO - PROCESS | 27845 | Values: 153.0 145.0 152.0 140.0 149.0 141.0 141.0 152.0 184.0 141.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.40 Median:181.50 stddev:1.96 (1.1%) stddev-sans-first:1.58 07:43:46 INFO - PROCESS | 27845 | Values: 185.0 182.0 179.0 182.0 181.0 181.0 179.0 184.0 181.0 180.0 07:43:46 INFO - PROCESS | 27845 | 07:43:46 INFO - PROCESS | 27845 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.50 stddev:2.02 (2.8%) stddev-sans-first:2.12 07:43:46 INFO - PROCESS | 27845 | Values: 71.0 71.0 72.0 75.0 71.0 75.0 70.0 70.0 70.0 74.0 07:43:46 INFO - PROCESS | 27845 | -------- Summary: end -------- 07:43:46 INFO - PROCESS | 27845 | 07:43:47 INFO - TEST-INFO | 27845: exit 0 07:43:47 INFO - TEST-OK | kraken | took 64785ms 07:43:47 INFO - SUITE-END | took 1186s 07:43:47 INFO - Completed test suite (00:19:47) 07:43:47 INFO - javascript benchmark 07:43:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2564.064116597442, 2575.3947822261775, 2611.1644273832376, 2619.947601047979, 2626.606009098634, 4424.845130420436, 4455.086707225019, 4607.815687372506, 4610.67725259232, 4635.559621835924, 4495.3257011448295, 4585.128825523148, 4604.263317869141, 4651.9302210466785, 4682.953170468286, 4193.140406216734, 4213.894652633693, 4251.4685664291965, 4276.593723596269, 4360.694751367406, 4214.136102099063, 4291.549387314334, 4296.699231053827, 4324.675649326297, 4362.1275744851155, 4187.036981494243, 4224.619784219435, 4262.722923009995, 4312.417823593806, 4350.8912277193, 4238.957610423918, 4257.8296868125235, 4260.9147817043795, 4275.828966841323, 4325.199838029975, 4230.619244267999, 4234.767087810169, 4235.830566777326, 4240.257954857888, 4270.188664153832, 4601.585857272828, 4635.976820115911, 4643.489216186251, 4665.46347170073, 4687.99208170245, 4782.952170478286, 4826.0347930414055, 4833.444153922309, 4884.389451318585, 4907.4356449008465, 4958.404991401055, 4961.950380496221, 4970.826021089245, 4998.600111991032, 5004.799808007675, 4628.467726211461, 4632.791524381411, 4633.096546173531, 4635.976820115945, 4669.486356500782, 4881.511848815161, 4905.509449055137, 4907.607391408679, 5058.317127187856, 5107.565856902131, 4841.080194762983, 4863.927041094315, 4878.9512104878495, 4905.5094490550655, 4908.460069392364, 4928.408590969107, 4939.135651261086, 4940.604751619861, 4941.357623508921, 4987.152184128707, 4905.411350637946, 4920.704757714549, 4932.186189278729, 4953.356063711694, 4973.577245934136, 4784.0, 4830.758462076952, 4832.057748738962, 4837.95162048382, 4856.441509226484, 4142.565030671736, 4153.460050193456, 4157.563455837094, 4164.958350416457, 4192.434021407132, 3635.5273814404486, 3639.9636003640153, 3644.052546337918, 3665.193657395369, 3672.632736726306, 4181.393697913785, 4211.957880421218, 4276.914461710749, 4279.935800962988, 4309.116631090619, 4865.513448655106, 4892.437369702458, 4906.58294045003, 4914.189158788759, 4915.16442204826, 4259.8083086261195, 4261.10516791471, 4263.296556068214, 4264.552222016706, 4266.722663026893, 4420.049689316748, 4422.933655995163, 4424.977875110604, 4425.6238219751685, 4426.336049592523, 4643.349931009661, 4646.907061858811, 4650.4186976627925, 4651.279051746985, 4651.720896746206, 4938.851834444972, 4962.851114466572, 4964.3298154748645, 4966.130927087817, 4968.0312339093525, 4630.699004564693, 4638.095571363552, 4673.275642275453, 4682.016776476978, 4741.431028276491, 4904.068227036852, 4906.656534042583, 4908.337374454403, 4909.1899836528, 4958.107540642719, 4956.3804524434445, 4972.378452693413, 4976.30331753562, 4992.775325110306, 5017.498250174954, 4730.101280756645, 4774.95225047745, 4777.784999675093, 4831.444383895897, 4832.420109586872, 4781.665283430127, 4815.3258543804595, 4824.56578907886, 4827.203511420576, 4828.4688684244, 4762.095201911626, 4769.689970151929, 4776.355192049168, 4803.279508073817, 4830.7826147824135, 4888.608911287018, 4905.48492408292, 4907.092187945242, 4912.606991440748, 4944.876378090433, 4683.555062269079, 4723.574878260973, 4742.952570474389, 4771.809127634856, 4780.760961951958], "value": 4535.089713481158, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.1390324142716, 564.8841987392585, 567.4807551090752, 571.0463525911726, 572.5705720709468, 27849.0, 30819.537706934385, 37974.81012594936, 38708.61291387085, 39081.80459097701, 38888.22223555527, 39234.41148382777, 39282.41076383857, 39362.0, 39482.40776388349, 7522.736704215367, 7669.463137580372, 7670.846583068335, 7672.194419585947, 7684.53892766433, 7284.745033923814, 7488.775336739906, 9514.286428517855, 9757.024297570257, 9763.121319081281, 9798.902010979906, 9889.75275618108, 9896.208303335716, 9898.158656514204, 9899.604015839357, 9607.0, 9683.0, 9685.757856053584, 9692.079252471003, 9693.612255509772, 9673.419594824332, 9816.803663926752, 9828.361156524803, 9830.164436022947, 9831.606735730562, 35599.4660080099, 36042.279154417025, 36052.278954421025, 36061.45907811385, 36061.63938360609, 3044.269375349922, 3139.4505961456653, 3148.244421338862, 3245.107595411257, 3291.358185153872, 27951.30121746952, 28076.0, 28135.296617584725, 28434.573481397794, 28627.713722862714, 3390.932181356384, 3425.6745609167087, 3455.3434847379167, 3472.305538892206, 3508.5088087667746, 246750.0, 246993.0, 247707.9999999982, 247916.0, 248367.0, 49381.75309123431, 49660.751696241285, 49674.75162624164, 49862.75068624706, 49972.25041624378, 51862.0, 52084.0, 52107.0, 52113.47886521162, 52128.0, 12934.935325323502, 13513.66215844592, 13551.25468099264, 13552.119112257671, 13556.186628802303, 8505.914940850636, 8898.06570310121, 9567.378120422289, 9706.417614943126, 9715.902840971641, 13582.660433489242, 13692.65768355799, 13696.383662735201, 15001.924990374979, 15454.150021748912, 5760.671378974515, 5790.971045144832, 5917.852053698606, 6000.3999600040515, 6011.7595296187665, 749.5315427857589, 783.4515838912783, 822.1490757066528, 897.210454799772, 938.2869019545195, 25634.743652563237, 26772.866135669585, 27180.86409567979, 27257.86371068132, 27398.260173982842, 914.6250037484599, 914.7072936660338, 921.7050543825911, 999.9050090241416, 1025.2771795883884, 13693.452261909611, 14343.85656143446, 14692.902445485217, 14755.188464634333, 14863.33115009827, 112506.43746781377, 113143.0, 113853.43073284581, 113897.4305128469, 114020.0, 46697.76651116791, 46744.766276168404, 46759.53240467552, 46820.0, 46833.0, 1131.3890499130378, 1136.5169802833764, 1147.0250287255933, 1157.976840463203, 1163.0637336943842, 24925.626115607916, 26026.0, 26643.770348606307, 27075.458490830468, 27182.184534464, 40145.1970960585, 40428.393574097, 40484.79757601193, 40512.59487405206, 40523.39214911838, 321146.0, 322667.0, 322899.0, 322905.0, 323341.0, 34010.65989340075, 34222.48666269958, 34692.826535867156, 34867.65132348644, 35084.824575876955, 38806.61193388143, 39092.413613795245, 39706.2058758829, 39893.800530997156, 39983.60016399799, 34159.14602134967, 34193.0, 34196.65803341935, 34319.485207722406, 34554.0, 33774.83112584421, 33958.49062264019, 33977.49033764446, 34146.48780268348, 34744.47883281804, 33762.83118584391, 34068.0, 34247.143821404665, 34268.48597271093, 34669.0, 29775.553366699085, 30726.84636576892, 30902.84548577243, 31291.374172516877, 31312.843435782674, 23547.41131471727, 23595.29214123579, 23772.881135594213, 24110.638340424557, 24210.87894560516], "value": 16658.394623960583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.6440708441968, 342.1053943936607, 353.7223279725415, 358.95692516897975, 378.39456869009587, 12457.128001039931, 15767.448139315125, 15966.28151733172, 16247.431339903105, 17328.480145595622, 16304.83695163051, 16613.50159495214, 16766.58083547912, 16875.324987000506, 16885.071321077336, 3875.3411919973673, 4809.90380192396, 4988.32657591226, 5019.723915184663, 5035.420926593433, 4967.403911530621, 4997.850064498053, 5035.84892453227, 5042.420121685998, 5045.596352291808, 4822.132016237076, 4907.067657145149, 4952.876178095558, 5008.073506401309, 5017.172166592508, 4915.188993816016, 4973.626977976648, 4976.800927962895, 4979.7261150636705, 4984.651074424792, 4475.7985890635, 4480.588614586395, 4482.372467854503, 4619.491855895849, 4870.829520966749, 11960.102992275613, 12166.5741699041, 12174.208676436092, 12176.269423834598, 13076.0, 1749.912504374776, 1797.0834874214115, 1922.6731455652432, 1959.7623266965506, 1996.620642078015, 8631.654733810703, 8725.301975841918, 8986.730398088068, 9143.862842057308, 9272.814543709088, 1606.7107920574292, 1672.9498115056567, 1702.6254224070685, 1720.0711615727491, 1725.7929048514134, 66894.0, 68308.6584567074, 69934.0, 71079.64460177666, 71132.0, 9707.90292097084, 9762.90237097634, 9780.657676981271, 10131.746706332253, 10140.847887281696, 13419.93290033563, 13442.46230150783, 13455.394507247198, 13458.192508449525, 13465.326733663278, 6699.430548403343, 6947.305269473113, 6954.582725036413, 7199.676014579357, 7201.495895287384, 6468.514861385415, 6472.288048314682, 6529.54293199481, 6549.6070235786, 6755.121834161626, 4108.281050816096, 4127.711060225755, 4235.0, 4257.63810076147, 4385.649148068147, 1753.2022929567017, 1780.4658602419222, 1788.0880750817178, 1788.2578729827237, 1818.1545581304756, 717.3938022371088, 788.8777239527882, 794.0630056533346, 819.2708489444399, 830.543201239316, 15618.297176627078, 16343.34626614946, 16591.751123733153, 17005.149742512825, 17215.0, 782.4131901074194, 782.7847341981001, 796.446469703562, 805.7663277649533, 860.9096044915319, 8829.911700882909, 9392.248620110511, 9415.293852960918, 9439.480828554495, 9569.138777509917, 316235.0, 368420.0, 377294.9516562884, 377924.0, 380505.0, 46344.76827615908, 61000.389996100355, 76999.61500192463, 77229.61385193038, 77967.61016194883, 848.0, 876.0669886570909, 877.4779006491127, 878.7319867440492, 883.4610887358706, 14942.672295356157, 15356.692866142392, 15805.972611780198, 15868.52394428169, 16113.597160071093, 34739.13152171115, 35170.64829351674, 35886.461703074994, 36136.0, 40001.0, 50577.24134138064, 50609.746951265006, 51052.23421648604, 51724.48275517347, 52697.0, 6795.38841504267, 7140.500164988401, 7190.0, 7226.74706385274, 7586.962065189638, 10560.207984401048, 12047.638570842888, 12149.392530373269, 12222.449989750305, 12779.041571882331, 9567.0, 9922.603095876084, 10224.591016359262, 10270.691879243635, 10711.036006759117, 9278.164965153168, 10024.298299119284, 10254.0, 10405.895941040493, 10438.21713371485, 10024.749381265527, 10099.646512372032, 10339.431331276852, 10508.369497830156, 10689.786204276026, 7507.249275072449, 7578.280063393969, 7786.571738554434, 7951.522908625501, 7979.281864632211, 7706.7687969361, 9898.208143348658, 10321.74195645115, 10558.947205263925, 10987.61543345979], "value": 7781.094165590506, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.8194252804606, 1352.8647135286471, 1382.9446822127115, 1598.650826518445, 1614.7174244507207, 6118.541109416789, 6309.085182648513, 6619.205695316563, 7032.472564557659, 7035.155781306244, 6581.506387020981, 6800.149981252343, 6811.659417029141, 6968.6864091115895, 6970.268121847209, 1997.1611922992379, 2027.3107143571183, 2029.3100345882397, 2030.9390718278476, 2032.0246281784678, 1847.168774051682, 1911.4170178095744, 2037.052770461735, 2053.1787285085934, 2063.4634994901357, 1831.6611426886002, 1878.1548303263519, 1879.7274395212687, 1985.067018501302, 2046.94882627934, 2054.311805545144, 2055.0649454498166, 2056.8765874047604, 2058.5471196336857, 2061.721667574888, 2042.1218875883364, 2066.617675729995, 2073.232903825579, 2074.8651337663155, 2075.95848083039, 6915.861682766367, 7096.609686467243, 7111.7866464006165, 7114.430845532345, 7119.715211391538, 4285.678574106923, 4406.7355958642265, 4412.492563355223, 4426.15902978433, 4433.534478879704, 2608.5304645163865, 2814.127620437671, 2814.451182019507, 2831.631887854566, 2861.241770930705, 832.3798769916391, 847.4110493207223, 850.961706723199, 851.9190676885686, 881.5239770523909, 8879.422837515542, 9088.136627020422, 9124.908750912473, 9394.953025234898, 9440.433573985514, 3757.28611563802, 3854.20988697322, 3935.330993731073, 3942.6057394260342, 3964.861229856941, 7080.893786593205, 7120.216776154619, 7126.180489243803, 7133.785986420416, 7144.178419481722, 4378.496472905656, 4382.496012958551, 4385.473743150842, 4387.648988080946, 4388.27593447084, 3938.3107956107565, 4093.263212621697, 4099.672026237894, 4102.220578090153, 4102.50769907607, 3087.9073627791204, 3108.968910310868, 3169.762267829922, 3224.290656055664, 3228.1606782236786, 978.1587834462357, 978.5351957819978, 985.571276494727, 986.2110311750571, 994.3437331361267, 708.7200555780438, 709.2729951799447, 743.9956059319983, 744.0661969228584, 753.3257734327746, 4773.856784296477, 4957.256411538298, 5130.691673623202, 5133.614978876599, 5237.764300606482, 764.4037650632515, 766.5400759544228, 791.6041979010495, 797.1669605262515, 848.749618862437, 3332.600087989457, 3397.813120278359, 3415.692587667122, 3452.4993875887853, 3469.5663042119736, 8187.4268801184535, 8296.211859873303, 8477.237048665527, 8477.74566762998, 8482.151784821468, 8058.758237252891, 8279.54462504568, 8288.088310285864, 8306.210909963544, 8326.876646455115, 6322.1981735205245, 6602.0, 6610.933890661128, 6614.371634694697, 6615.338466153443, 4916.70499770015, 4997.825076122318, 5088.771005304844, 5144.794208231779, 5296.894062118659, 7668.348190403655, 7772.68909243624, 7896.565688887166, 8020.478668886503, 8058.194180581895, 7766.417518686234, 7866.685332586632, 7870.606469676608, 7912.248336408032, 7918.208179182036, 6106.084087386927, 6198.039303907902, 6208.037754148114, 6226.377362263918, 6228.252609686867, 6657.034729964225, 6671.232808226922, 6692.0, 6730.495212859153, 6753.527253092237, 6095.817125486243, 6119.755209791559, 6132.386761323832, 6198.504119670325, 6231.937680623136, 5969.791057312973, 6021.789237376671, 6133.202683651097, 6200.968995154995, 6290.21372328459, 5770.365259821332, 5797.681127537857, 5812.070068789142, 5817.069268916953, 5829.883402331845, 4194.4337514435165, 4269.487661480518, 4292.270314046557, 4394.736315821061, 4480.663950203813, 4183.184279065553, 4273.686612852758, 4341.110072435206, 4420.690551661352, 4533.977330113328], "value": 3768.170151887777, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.79453307286076, 295.3914935233421, 300.46067309180023, 303.24038284098333, 303.6629341431012, 4580.748058856761, 4730.787114579844, 4804.189549113773, 4813.133635945528, 4821.577634597793, 4652.255639097745, 4748.002919386933, 4769.8807529811775, 4780.282957556368, 4788.281757736341, 3753.099256178511, 3761.605031471697, 3769.151940813316, 3779.7354185207046, 3792.8482860685676, 3561.5904171020406, 3651.543557055368, 3660.7071434285326, 3759.3045286622064, 3773.735718603402, 3700.7964561949084, 3703.925921481569, 3727.589965103836, 3732.4961130247475, 3736.2252929858237, 3735.14091758897, 3737.6075512071384, 3741.2143449875557, 3756.3050835595504, 3781.8865434037025, 3343.8996830095134, 3358.7480938929434, 3359.5800524934384, 3361.5798025246845, 3377.273886114497, 4460.531644177379, 4644.489106198315, 4672.5327467253, 4685.929711054337, 4750.857474275777, 4228.76741779202, 4236.9364459533135, 4258.084511829971, 4278.828846846122, 4280.443542339476, 4941.7034977901085, 4966.453690094087, 4971.428285747149, 4988.301637770715, 4991.675541089818, 3488.825558722079, 3571.8035508047046, 3573.5711714594154, 3591.712662986955, 3601.225736466646, 5138.486151384869, 5157.200633901752, 5158.638895277332, 5212.1921102228835, 5221.968626236627, 3786.583475817658, 3789.5452545694693, 3795.221979494197, 3811.447340135665, 3813.7773581323736, 3854.8843534694006, 3859.0931131184147, 3865.613438656112, 3867.419887016914, 3874.5737968823405, 4046.107033471082, 4244.617984381421, 4248.91502169961, 4254.957450425518, 4254.957705240768, 4946.455889852114, 4951.207806750903, 4966.180580204225, 4967.950320496821, 4973.925391119136, 1249.1505776072177, 1273.688101255708, 1281.3080936294482, 1282.2178471132602, 1284.8907842833278, 891.38494438837, 903.3676426501344, 904.4076130134772, 916.8303863785088, 917.1195652173855, 4264.637505812041, 4277.550857160016, 4285.764282964405, 4308.612224899774, 4320.956790432118, 4940.431850337257, 4951.801927922843, 4952.752362381866, 4961.50384961501, 5025.271335656309, 4267.829286828554, 4270.466191726035, 4285.700000999963, 4292.291771857671, 4308.655307575386, 2517.8111641626583, 2643.2863126956, 2644.8942042318477, 2657.8006649500976, 2660.348214687414, 4717.551832575969, 4717.867711749155, 4741.620670346433, 4741.881452963704, 4763.1426343258545, 4854.320395144682, 5123.769430375642, 5124.769385377667, 5128.512791284897, 5135.563477104413, 4681.812727490862, 4704.741239231738, 4705.482396936334, 4705.847067468424, 4714.6464015199, 4991.625628077836, 4998.475160108282, 5000.699958002531, 5000.749962501933, 5020.49795020495, 4829.492903245108, 4921.212605983169, 4921.876953076202, 4952.826651067196, 4966.900661986668, 4795.256735206049, 4855.5676075557085, 4866.8053277868485, 4869.415670119608, 4875.609951203966, 3597.028802223437, 3598.694111000594, 3626.437902125175, 3635.8909232723063, 3650.9634903651686, 5049.400652018689, 5090.516400941905, 5100.591952643706, 5186.481351864783, 5207.0, 4955.108080545537, 4967.3045773591, 4970.155073637418, 4972.229304457815, 4973.303737476828, 4976.353074100344, 4979.427365852828, 4996.650234483552, 5001.549860512571, 5017.37282839645, 4713.646476514206, 4849.957259189291, 4865.854024379274, 4873.220284754422, 4909.846186146324, 5007.873228523698, 5018.749062546931, 5023.648344615988, 5024.84925452237, 5030.320906677552, 4902.803887844446, 4907.97546012282, 4916.483769204325, 4928.507149285043, 4938.777755000961], "value": 3757.852004141105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.5288944849154, 671.5198632977421, 689.3554526517706, 714.4855703893198, 723.9022731931187, 12380.81428778569, 13383.73232535351, 13409.999999999987, 13429.32853357333, 13439.59681209564, 12781.808272875915, 12916.612501624966, 12983.480660773557, 12995.610131696065, 13025.544105956293, 602.1209034809184, 619.5446346934999, 732.8351120997772, 746.0599644447981, 748.6256871564218, 725.8838585826269, 745.757628770649, 755.2673906310897, 755.9924400756005, 756.670848181043, 792.7344339646226, 798.1340245833278, 800.0399520575304, 801.9975031210986, 802.2859654907137, 626.6709977261928, 645.1000853808957, 788.6924099601132, 797.178905727102, 797.5453991225004, 558.1293182635062, 573.6672729816696, 577.1112486770369, 577.9248697669318, 578.9305283366023, 12488.687782805502, 12533.248005119722, 12541.122121451503, 12545.498180072786, 12550.560730374484, 12305.200161989442, 12364.44360003802, 12797.936010319889, 12876.742465150739, 13125.540606078837, 9260.722178334661, 9306.488143152124, 9790.5594248259, 9808.705738827846, 9855.753606159831, 4047.8988025299604, 4069.267531844267, 4077.1234184650443, 4096.959030409687, 4127.360259159805, 62587.37412625906, 64244.35755642477, 66164.6691766543, 66688.3331166687, 67437.6628116866, 10017.749556261006, 10192.592296308212, 10195.541200645841, 10280.948595256976, 10392.22058345612, 16693.415730449375, 16833.83166168347, 17078.146092695315, 17591.120443978005, 17613.20740566652, 6411.455026322721, 6421.1230277661, 6556.27880933097, 6569.9343006569325, 6601.141851559362, 3578.2306804037257, 3592.928141437209, 3641.927161456756, 3663.19409729859, 3702.1670124222373, 2871.1386584025126, 2966.985165074204, 2969.0, 2975.0925967580097, 3005.54916762483, 506.2861365474737, 509.5032343465092, 512.2802462540062, 520.7396301849076, 527.5120513524975, 592.5541678304922, 599.1791245993018, 601.7695599932395, 608.5983251054283, 618.7524990004034, 7502.549847009197, 7659.885101723478, 7726.141327708784, 8016.630936139818, 8072.273495385443, 482.4692837878376, 544.4555444555444, 564.4750382144645, 579.0705917003233, 580.7241560258927, 3737.981310093432, 3875.1668391296007, 3926.371780515104, 4015.417764424142, 4111.321631930758, 70383.64808175927, 71642.64178679073, 73528.0, 74158.6292068547, 74393.0, 52394.73802630963, 55949.44050559442, 62986.0, 64391.67804161043, 64462.6776866122, 57613.711931440914, 58413.70793146092, 59166.112508312406, 59808.70095649494, 60012.69993650004, 7592.535271739603, 7848.0, 7996.0, 8116.837663246584, 8139.83720325602, 40788.79605601953, 40910.0, 41452.0, 41604.79197603992, 42308.788456057526, 52001.7399912998, 54899.72550137224, 55060.72469637626, 55605.0, 56430.43569564252, 9472.384295020802, 9568.808623827623, 9634.13292803651, 9839.311248212844, 9996.950015250168, 11081.445927703744, 11350.318980861175, 11368.886311136783, 11415.543378264776, 11830.231034982698, 10344.120749736056, 10448.373097614167, 10571.524281407508, 10578.206634502289, 11275.097992160772, 10148.847767283645, 10322.277440579088, 10464.895351046393, 10519.474026298807, 10956.835647465454, 10368.896311036793, 10488.0, 10536.315139515908, 10939.45302734876, 11044.723881903017, 8085.959570202347, 8157.143499932659, 8470.534120623424, 8531.53076580794, 8708.433951793113, 7548.698052078075, 7555.13115991668, 7570.205128461653, 7710.190430004769, 7870.331021863206], "value": 6122.92384850612, "unit": "score"}], "name": "dromaeo_css", "value": 6089.150345485988, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 116.0, 114.0, 116.0, 115.0, 113.0, 113.0, 113.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 127.0, 166.0, 132.0, 133.0, 128.0, 132.0, 160.0, 130.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 164.0, 163.0, 163.0, 161.0, 162.0, 162.0, 161.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 115.0, 78.0, 76.0, 78.0, 76.0, 94.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 108.0, 83.0, 83.0, 83.0, 104.0, 84.0, 83.0, 112.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 71.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 98.0, 89.0, 93.0, 84.0, 94.0, 86.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 145.0, 152.0, 140.0, 149.0, 141.0, 141.0, 152.0, 184.0, 141.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 179.0, 182.0, 181.0, 181.0, 179.0, 184.0, 181.0, 180.0], "value": 181.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 75.0, 71.0, 75.0, 70.0, 70.0, 70.0, 74.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1574.1000000000001, "alertThreshold": 2.0}]} 07:43:48 INFO - Return code: 0 07:43:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:43:48 INFO - # TBPL SUCCESS # 07:43:48 INFO - Running post-action listener: _resource_record_post_action 07:43:48 INFO - [mozharness: 2016-12-03 15:43:48.110065Z] Finished run-tests step (success) 07:43:48 INFO - Running post-run listener: _resource_record_post_run 07:43:48 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 2297856; Write bytes: 404963328; Read time: 1280; Write time: 214852 07:43:48 INFO - TinderboxPrint: CPU usage
13.1% 07:43:48 INFO - TinderboxPrint: I/O read bytes / time
2,297,856 / 1,280 07:43:48 INFO - TinderboxPrint: I/O write bytes / time
404,963,328 / 214,852 07:43:48 INFO - TinderboxPrint: CPU idle
8,341.6 (86.9%) 07:43:48 INFO - TinderboxPrint: CPU user
1,208.5 (12.6%) 07:43:48 INFO - TinderboxPrint: Swap in / out
0 / 0 07:43:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99930112; Read time: 0; Write time: 56660 07:43:48 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 2293760; Write bytes: 293789696; Read time: 1260; Write time: 155824 07:43:48 INFO - Running post-run listener: _upload_blobber_files 07:43:48 INFO - Blob upload gear active. 07:43:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:43:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:43:49 INFO - (blobuploader) - INFO - Open directory for files ... 07:43:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:43:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:43:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:50 INFO - (blobuploader) - INFO - Done attempting. 07:43:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:43:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:51 INFO - (blobuploader) - INFO - Done attempting. 07:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:43:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:55 INFO - (blobuploader) - INFO - Done attempting. 07:43:55 INFO - (blobuploader) - INFO - Iteration through files over. 07:43:55 INFO - Return code: 0 07:43:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:43:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:43:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/568566c365df0db380a298d66592a4ec435d2f4d4d33fdc7e2879e00a9acacd2a59aaac6590f6c6bff95d9e4d701e84998969dbf3b45715f6dac5342b2d2a1f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c95ac891e508176b8785b1dea5042818622f6b85c1f953eb7da763f9365347477c7c3f93be6946e64c7b04993b586a7649ebca00c9ce4a357fa83a7be1577f67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b9a32eb028b769932e8c6d20f8c74e6e2efad4bea823cd030975ab22f807a0702dd658a041044dd47370d857bce77738e7ca2507575149a686930e19e64c27b"} 07:43:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:43:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:43:55 INFO - Contents: 07:43:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/568566c365df0db380a298d66592a4ec435d2f4d4d33fdc7e2879e00a9acacd2a59aaac6590f6c6bff95d9e4d701e84998969dbf3b45715f6dac5342b2d2a1f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c95ac891e508176b8785b1dea5042818622f6b85c1f953eb7da763f9365347477c7c3f93be6946e64c7b04993b586a7649ebca00c9ce4a357fa83a7be1577f67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b9a32eb028b769932e8c6d20f8c74e6e2efad4bea823cd030975ab22f807a0702dd658a041044dd47370d857bce77738e7ca2507575149a686930e19e64c27b"} 07:43:55 INFO - Running post-run listener: copy_logs_to_upload_dir 07:43:55 INFO - Copying logs to upload dir... 07:43:55 INFO - mkdir: /builds/slave/test/build/upload/logs 07:43:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.963429 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-03 07:43:54.409674) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 07:43:54.413356) ========= 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=6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/568566c365df0db380a298d66592a4ec435d2f4d4d33fdc7e2879e00a9acacd2a59aaac6590f6c6bff95d9e4d701e84998969dbf3b45715f6dac5342b2d2a1f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c95ac891e508176b8785b1dea5042818622f6b85c1f953eb7da763f9365347477c7c3f93be6946e64c7b04993b586a7649ebca00c9ce4a357fa83a7be1577f67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b9a32eb028b769932e8c6d20f8c74e6e2efad4bea823cd030975ab22f807a0702dd658a041044dd47370d857bce77738e7ca2507575149a686930e19e64c27b"} build_url:https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011779 build_url: 'https://queue.taskcluster.net/v1/task/YJfF-E74TtSYeXruf6dM-A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/568566c365df0db380a298d66592a4ec435d2f4d4d33fdc7e2879e00a9acacd2a59aaac6590f6c6bff95d9e4d701e84998969dbf3b45715f6dac5342b2d2a1f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c95ac891e508176b8785b1dea5042818622f6b85c1f953eb7da763f9365347477c7c3f93be6946e64c7b04993b586a7649ebca00c9ce4a357fa83a7be1577f67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b9a32eb028b769932e8c6d20f8c74e6e2efad4bea823cd030975ab22f807a0702dd658a041044dd47370d857bce77738e7ca2507575149a686930e19e64c27b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 07:43:54.443701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 07:43:54.444135) ========= 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=6d15e502d8e29d5d2676d664000001c3-1480775117.999951-1663455490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 07:43:54.528046) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 07:43:54.529100) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 07:43:54.529810) ========= ========= Total master_lag: 0.18 =========