builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1484081975.77 results: success (0) buildid: 20170110111805 builduid: ef276f4604b840768492dd7872f4931f revision: 95d20a617288dde9faff91e847d414bb3403c157 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:35.768947) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:35.769353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:35.769643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:35.786070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:35.786342) ========= 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=ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-10 12:59:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.5M=0s 2017-01-10 12:59:36 (45.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115643 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:36.155016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:36.155321) ========= 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=ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013489 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:36.186220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:36.186544) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 95d20a617288dde9faff91e847d414bb3403c157 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 95d20a617288dde9faff91e847d414bb3403c157 --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=ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-10 12:59:36,745 truncating revision to first 12 chars 2017-01-10 12:59:36,745 Setting DEBUG logging. 2017-01-10 12:59:36,745 attempt 1/10 2017-01-10 12:59:36,745 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/95d20a617288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 12:59:37,101 unpacking tar archive at: mozilla-beta-95d20a617288/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701052 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:36.905887) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:36.906207) ========= script_repo_revision: 95d20a617288dde9faff91e847d414bb3403c157 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:36.906602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:36.906869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 12:59:36.916810) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-10 12:59:36.917096) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:59:37 INFO - MultiFileLogger online at 20170110 12:59:37 in /builds/slave/test 12:59:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:59:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:59:37 INFO - {'append_to_log': False, 12:59:37 INFO - 'base_work_dir': '/builds/slave/test', 12:59:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:59:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:59:37 INFO - 'branch': 'Mozilla-Beta', 12:59:37 INFO - 'buildbot_json_path': 'buildprops.json', 12:59:37 INFO - 'config_files': ('talos/linux_config.py',), 12:59:37 INFO - 'default_actions': ('clobber', 12:59:37 INFO - 'read-buildbot-config', 12:59:37 INFO - 'download-and-extract', 12:59:37 INFO - 'populate-webroot', 12:59:37 INFO - 'create-virtualenv', 12:59:37 INFO - 'install', 12:59:37 INFO - 'run-tests'), 12:59:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:59:37 INFO - 'download_minidump_stackwalk': True, 12:59:37 INFO - 'download_symbols': 'ondemand', 12:59:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:59:37 INFO - 'tooltool.py': '/tools/tooltool.py', 12:59:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:59:37 INFO - '/tools/misc-python/virtualenv.py')}, 12:59:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:59:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:59:37 INFO - 'installer_path': 'installer.exe', 12:59:37 INFO - 'log_level': 'info', 12:59:37 INFO - 'log_name': 'talos', 12:59:37 INFO - 'log_to_console': True, 12:59:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:59:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:59:37 INFO - 'opt_config_files': (), 12:59:37 INFO - 'pip_index': False, 12:59:37 INFO - 'sps_profile': False, 12:59:37 INFO - 'sps_profile_interval': 0, 12:59:37 INFO - 'suite': 'dromaeojs', 12:59:37 INFO - 'system_bits': '32', 12:59:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:59:37 INFO - 'title': 'talos-linux64-ix-029', 12:59:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:59:37 INFO - 'use_talos_json': True, 12:59:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:59:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:59:37 INFO - 'work_dir': 'build'} 12:59:37 INFO - [mozharness: 2017-01-10 20:59:37.564734Z] Running clobber step. 12:59:37 INFO - Running pre-action listener: _resource_record_pre_action 12:59:37 INFO - Running main action method: clobber 12:59:37 INFO - rmtree: /builds/slave/test/build 12:59:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:59:38 INFO - Running post-action listener: _resource_record_post_action 12:59:38 INFO - [mozharness: 2017-01-10 20:59:38.024176Z] Finished clobber step (success) 12:59:38 INFO - [mozharness: 2017-01-10 20:59:38.024278Z] Running read-buildbot-config step. 12:59:38 INFO - Running pre-action listener: _resource_record_pre_action 12:59:38 INFO - Running main action method: read_buildbot_config 12:59:38 INFO - Using buildbot properties: 12:59:38 INFO - { 12:59:38 INFO - "project": "", 12:59:38 INFO - "product": "firefox", 12:59:38 INFO - "script_repo_revision": "production", 12:59:38 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:59:38 INFO - "repository": "", 12:59:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:59:38 INFO - "buildid": "20170110111805", 12:59:38 INFO - "pgo_build": "True", 12:59:38 INFO - "basedir": "/builds/slave/test", 12:59:38 INFO - "buildnumber": 511, 12:59:38 INFO - "slavename": "talos-linux64-ix-029", 12:59:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:59:38 INFO - "platform": "ubuntu64_hw", 12:59:38 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:59:38 INFO - "branch": "mozilla-beta", 12:59:38 INFO - "repo_path": "releases/mozilla-beta", 12:59:38 INFO - "revision": "95d20a617288dde9faff91e847d414bb3403c157", 12:59:38 INFO - "stage_platform": "linux64-pgo", 12:59:38 INFO - "builduid": "ef276f4604b840768492dd7872f4931f", 12:59:38 INFO - "slavebuilddir": "test" 12:59:38 INFO - } 12:59:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 12:59:38 INFO - Running post-action listener: _resource_record_post_action 12:59:38 INFO - [mozharness: 2017-01-10 20:59:38.026735Z] Finished read-buildbot-config step (success) 12:59:38 INFO - [mozharness: 2017-01-10 20:59:38.026824Z] Running download-and-extract step. 12:59:38 INFO - Running pre-action listener: _resource_record_pre_action 12:59:38 INFO - Running main action method: download_and_extract 12:59:38 INFO - mkdir: /builds/slave/test/build/tests 12:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:38 INFO - trying https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 12:59:38 INFO - Downloading https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 12:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:59:38 INFO - Downloaded 1327 bytes. 12:59:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 12:59:38 INFO - Using the following test package requirements: 12:59:38 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 12:59:38 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:59:38 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:59:38 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:59:38 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 12:59:38 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:59:38 INFO - u'jsshell-linux-x86_64.zip'], 12:59:38 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:59:38 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:59:38 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 12:59:38 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:59:38 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 12:59:38 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:59:38 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 12:59:38 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:59:38 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:59:38 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:59:38 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:59:38 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:59:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 12:59:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:59:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 12:59:39 INFO - Expected file size: 21970618 12:59:43 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:59:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 12:59:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:59:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 12:59:44 INFO - Expected file size: 21970618 12:59:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 12:59:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:59:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 12:59:49 INFO - Expected file size: 14414089 12:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:49 INFO - trying https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 12:59:49 INFO - Downloading https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 12:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:59:50 INFO - Downloaded 56999458 bytes. 12:59:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 12:59:50 INFO - mkdir: /builds/slave/test/properties 12:59:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:59:50 INFO - Writing to file /builds/slave/test/properties/build_url 12:59:50 INFO - Contents: 12:59:50 INFO - build_url:https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 12:59:51 INFO - Running post-action listener: _resource_record_post_action 12:59:51 INFO - Running post-action listener: set_extra_try_arguments 12:59:51 INFO - [mozharness: 2017-01-10 20:59:51.423677Z] Finished download-and-extract step (success) 12:59:51 INFO - [mozharness: 2017-01-10 20:59:51.423981Z] Running populate-webroot step. 12:59:51 INFO - Running pre-action listener: _resource_record_pre_action 12:59:51 INFO - Running main action method: populate_webroot 12:59:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:59:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:59:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:59:51 INFO - '--tppagecycles', 12:59:51 INFO - '7'], 12:59:51 INFO - 'tests': ['tsvgm']}}, 12:59:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:59:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:59:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:59:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:59:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:51 INFO - 'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:59:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:51 INFO - 'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['damp', 'tps']}, 12:59:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:51 INFO - 'tests': ['damp', 'tps']}, 12:59:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['dromaeo_dom']}, 12:59:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:59:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['basic_compositor_video']}, 12:59:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:59:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['a11yr', 12:59:51 INFO - 'ts_paint', 12:59:51 INFO - 'tpaint', 12:59:51 INFO - 'sessionrestore', 12:59:51 INFO - 'sessionrestore_no_auto_restore', 12:59:51 INFO - 'tabpaint']}, 12:59:51 INFO - 'other-e10s': {'tests': ['a11yr', 12:59:51 INFO - 'ts_paint', 12:59:51 INFO - 'tpaint', 12:59:51 INFO - 'sessionrestore', 12:59:51 INFO - 'sessionrestore_no_auto_restore', 12:59:51 INFO - 'tabpaint']}, 12:59:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:59:51 INFO - 'ts_paint', 12:59:51 INFO - 'tpaint', 12:59:51 INFO - 'sessionrestore', 12:59:51 INFO - 'sessionrestore_no_auto_restore', 12:59:51 INFO - 'tabpaint']}, 12:59:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:59:51 INFO - 'ts_paint', 12:59:51 INFO - 'tpaint', 12:59:51 INFO - 'sessionrestore', 12:59:51 INFO - 'sessionrestore_no_auto_restore', 12:59:51 INFO - 'tabpaint']}, 12:59:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['a11yr', 12:59:51 INFO - 'ts_paint', 12:59:51 INFO - 'tpaint', 12:59:51 INFO - 'sessionrestore', 12:59:51 INFO - 'sessionrestore_no_auto_restore', 12:59:51 INFO - 'tabpaint']}, 12:59:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['a11yr', 12:59:51 INFO - 'ts_paint', 12:59:51 INFO - 'tpaint', 12:59:51 INFO - 'sessionrestore', 12:59:51 INFO - 'sessionrestore_no_auto_restore', 12:59:51 INFO - 'tabpaint']}, 12:59:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['tsvgx', 12:59:51 INFO - 'tsvgr_opacity', 12:59:51 INFO - 'tart', 12:59:51 INFO - 'tscrollx', 12:59:51 INFO - 'cart']}, 12:59:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:59:51 INFO - 'tsvgr_opacity', 12:59:51 INFO - 'tart', 12:59:51 INFO - 'tscrollx', 12:59:51 INFO - 'cart']}, 12:59:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:51 INFO - 'talos_options': ['--disable-e10s'], 12:59:51 INFO - 'tests': ['tp5o']}, 12:59:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:51 INFO - 'tests': ['tp5o']}, 12:59:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:51 INFO - 'talos_options': ['--disable-e10s', 12:59:51 INFO - '--xperf_path', 12:59:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:51 INFO - 'tests': ['tp5n']}, 12:59:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:59:51 INFO - 'talos_options': ['--xperf_path', 12:59:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:59:51 INFO - 'tests': ['tp5n']}}, 12:59:51 INFO - 'talos.zip': {'path': '', 12:59:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:59:51 INFO - Running post-action listener: _resource_record_post_action 12:59:51 INFO - [mozharness: 2017-01-10 20:59:51.444863Z] Finished populate-webroot step (success) 12:59:51 INFO - [mozharness: 2017-01-10 20:59:51.444962Z] Running create-virtualenv step. 12:59:51 INFO - Running pre-action listener: _resource_record_pre_action 12:59:51 INFO - Running main action method: create_virtualenv 12:59:51 INFO - Creating virtualenv /builds/slave/test/build/venv 12:59:51 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 12:59:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:59:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:59:51 INFO - Using real prefix '/usr' 12:59:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:59:52 INFO - Installing distribute.............................................................................................................................................................................................done. 12:59:53 INFO - Installing pip.................done. 12:59:54 INFO - Return code: 0 12:59:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:59:54 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')]} 12:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:54 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')]} 12:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:54 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 0x7f2a4e565f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', '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 12:59:54 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 12:59:54 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 12:59:54 INFO - Using env: {'DISPLAY': ':0', 12:59:54 INFO - 'HOME': '/home/cltbld', 12:59:54 INFO - 'LANG': 'en_US.UTF-8', 12:59:54 INFO - 'LANGUAGE': 'en_US:en', 12:59:54 INFO - 'LOGNAME': 'cltbld', 12:59:54 INFO - 'MAIL': '/var/mail/cltbld', 12:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:54 INFO - 'MOZ_NO_REMOTE': '1', 12:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:54 INFO - 'NO_EM_RESTART': '1', 12:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:54 INFO - 'PWD': '/builds/slave/test', 12:59:54 INFO - 'SHELL': '/bin/bash', 12:59:54 INFO - 'SHLVL': '1', 12:59:54 INFO - 'TERM': 'linux', 12:59:54 INFO - 'TMOUT': '86400', 12:59:54 INFO - 'USER': 'cltbld', 12:59:54 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 12:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:54 INFO - '_': '/tools/buildbot/bin/python'} 12:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:54 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 12:59:54 INFO - Cleaning up... 12:59:54 INFO - Return code: 0 12:59:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:59:54 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')]} 12:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:54 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')]} 12:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:54 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 0x7f2a4e565f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', '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 12:59:54 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 12:59:54 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 12:59:54 INFO - Using env: {'DISPLAY': ':0', 12:59:54 INFO - 'HOME': '/home/cltbld', 12:59:54 INFO - 'LANG': 'en_US.UTF-8', 12:59:54 INFO - 'LANGUAGE': 'en_US:en', 12:59:54 INFO - 'LOGNAME': 'cltbld', 12:59:54 INFO - 'MAIL': '/var/mail/cltbld', 12:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:54 INFO - 'MOZ_NO_REMOTE': '1', 12:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:54 INFO - 'NO_EM_RESTART': '1', 12:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:54 INFO - 'PWD': '/builds/slave/test', 12:59:54 INFO - 'SHELL': '/bin/bash', 12:59:54 INFO - 'SHLVL': '1', 12:59:54 INFO - 'TERM': 'linux', 12:59:54 INFO - 'TMOUT': '86400', 12:59:54 INFO - 'USER': 'cltbld', 12:59:54 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 12:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:54 INFO - '_': '/tools/buildbot/bin/python'} 12:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:54 INFO - Downloading/unpacking psutil>=3.1.1 12:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:59:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:56 INFO - Installing collected packages: psutil 12:59:56 INFO - Running setup.py install for psutil 12:59:56 INFO - building 'psutil._psutil_linux' extension 12:59:56 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 12:59:56 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 12:59:56 INFO - building 'psutil._psutil_posix' extension 12:59:56 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 12:59:56 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 12:59:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:57 INFO - Successfully installed psutil 12:59:57 INFO - Cleaning up... 12:59:57 INFO - Return code: 0 12:59:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:59:57 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')]} 12:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:57 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')]} 12:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:57 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 0x7f2a4e565f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', '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 12:59:57 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 12:59:57 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 12:59:57 INFO - Using env: {'DISPLAY': ':0', 12:59:57 INFO - 'HOME': '/home/cltbld', 12:59:57 INFO - 'LANG': 'en_US.UTF-8', 12:59:57 INFO - 'LANGUAGE': 'en_US:en', 12:59:57 INFO - 'LOGNAME': 'cltbld', 12:59:57 INFO - 'MAIL': '/var/mail/cltbld', 12:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:57 INFO - 'MOZ_NO_REMOTE': '1', 12:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:57 INFO - 'NO_EM_RESTART': '1', 12:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:57 INFO - 'PWD': '/builds/slave/test', 12:59:57 INFO - 'SHELL': '/bin/bash', 12:59:57 INFO - 'SHLVL': '1', 12:59:57 INFO - 'TERM': 'linux', 12:59:57 INFO - 'TMOUT': '86400', 12:59:57 INFO - 'USER': 'cltbld', 12:59:57 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 12:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:57 INFO - '_': '/tools/buildbot/bin/python'} 12:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:59:57 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 12:59:57 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 12:59:57 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 12:59:57 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 12:59:57 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 12:59:57 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 12:59:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:59:59 INFO - Installing collected packages: mozsystemmonitor 12:59:59 INFO - Running setup.py install for mozsystemmonitor 12:59:59 INFO - Successfully installed mozsystemmonitor 12:59:59 INFO - Cleaning up... 12:59:59 INFO - Return code: 0 12:59:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:59 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 0x7f2a4e565f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', '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 12:59:59 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 12:59:59 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 12:59:59 INFO - Using env: {'DISPLAY': ':0', 12:59:59 INFO - 'HOME': '/home/cltbld', 12:59:59 INFO - 'LANG': 'en_US.UTF-8', 12:59:59 INFO - 'LANGUAGE': 'en_US:en', 12:59:59 INFO - 'LOGNAME': 'cltbld', 12:59:59 INFO - 'MAIL': '/var/mail/cltbld', 12:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:59 INFO - 'MOZ_NO_REMOTE': '1', 12:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:59 INFO - 'NO_EM_RESTART': '1', 12:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:59 INFO - 'PWD': '/builds/slave/test', 12:59:59 INFO - 'SHELL': '/bin/bash', 12:59:59 INFO - 'SHLVL': '1', 12:59:59 INFO - 'TERM': 'linux', 12:59:59 INFO - 'TMOUT': '86400', 12:59:59 INFO - 'USER': 'cltbld', 12:59:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 12:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:59 INFO - '_': '/tools/buildbot/bin/python'} 12:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:59 INFO - Downloading/unpacking jsonschema==2.5.1 12:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:00:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:01 INFO - Downloading functools32-3.2.3-2.tar.gz 13:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:00:01 INFO - warning: no files found matching '*.txt' 13:00:01 INFO - no previously-included directories found matching 'build' 13:00:01 INFO - no previously-included directories found matching 'dist' 13:00:01 INFO - no previously-included directories found matching '.git*' 13:00:01 INFO - Installing collected packages: jsonschema, functools32 13:00:02 INFO - Running setup.py install for functools32 13:00:02 INFO - warning: no files found matching '*.txt' 13:00:02 INFO - no previously-included directories found matching 'build' 13:00:02 INFO - no previously-included directories found matching 'dist' 13:00:02 INFO - no previously-included directories found matching '.git*' 13:00:02 INFO - Successfully installed jsonschema functools32 13:00:02 INFO - Cleaning up... 13:00:02 INFO - Return code: 0 13:00:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:02 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 0x7f2a4e565f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', '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 13:00:02 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 13:00:02 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 13:00:02 INFO - Using env: {'DISPLAY': ':0', 13:00:02 INFO - 'HOME': '/home/cltbld', 13:00:02 INFO - 'LANG': 'en_US.UTF-8', 13:00:02 INFO - 'LANGUAGE': 'en_US:en', 13:00:02 INFO - 'LOGNAME': 'cltbld', 13:00:02 INFO - 'MAIL': '/var/mail/cltbld', 13:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:02 INFO - 'MOZ_NO_REMOTE': '1', 13:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:02 INFO - 'NO_EM_RESTART': '1', 13:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:02 INFO - 'PWD': '/builds/slave/test', 13:00:02 INFO - 'SHELL': '/bin/bash', 13:00:02 INFO - 'SHLVL': '1', 13:00:02 INFO - 'TERM': 'linux', 13:00:02 INFO - 'TMOUT': '86400', 13:00:02 INFO - 'USER': 'cltbld', 13:00:02 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 13:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:02 INFO - '_': '/tools/buildbot/bin/python'} 13:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:00:02 INFO - Cleaning up... 13:00:02 INFO - Return code: 0 13:00:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:02 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 0x7f2a4e565f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', '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 13:00:02 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 13:00:02 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 13:00:02 INFO - Using env: {'DISPLAY': ':0', 13:00:02 INFO - 'HOME': '/home/cltbld', 13:00:02 INFO - 'LANG': 'en_US.UTF-8', 13:00:02 INFO - 'LANGUAGE': 'en_US:en', 13:00:02 INFO - 'LOGNAME': 'cltbld', 13:00:02 INFO - 'MAIL': '/var/mail/cltbld', 13:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:02 INFO - 'MOZ_NO_REMOTE': '1', 13:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:02 INFO - 'NO_EM_RESTART': '1', 13:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:02 INFO - 'PWD': '/builds/slave/test', 13:00:02 INFO - 'SHELL': '/bin/bash', 13:00:02 INFO - 'SHLVL': '1', 13:00:02 INFO - 'TERM': 'linux', 13:00:02 INFO - 'TMOUT': '86400', 13:00:02 INFO - 'USER': 'cltbld', 13:00:02 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 13:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:02 INFO - '_': '/tools/buildbot/bin/python'} 13:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:02 INFO - Downloading/unpacking blobuploader==1.2.4 13:00:02 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 13:00:02 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 13:00:02 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 13:00:02 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 13:00:02 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 13:00:02 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 13:00:04 INFO - Downloading blobuploader-1.2.4.tar.gz 13:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:00:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:00:04 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 13:00:04 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 13:00:04 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 13:00:04 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 13:00:04 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 13:00:04 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 13:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:00:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:00:05 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 13:00:05 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 13:00:05 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 13:00:05 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 13:00:05 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 13:00:05 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 13:00:05 INFO - Downloading docopt-0.6.1.tar.gz 13:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:00:05 INFO - Installing collected packages: blobuploader, requests, docopt 13:00:05 INFO - Running setup.py install for blobuploader 13:00:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:00:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:00:05 INFO - Running setup.py install for requests 13:00:05 INFO - Running setup.py install for docopt 13:00:05 INFO - Successfully installed blobuploader requests docopt 13:00:05 INFO - Cleaning up... 13:00:05 INFO - Return code: 0 13:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:05 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 0x7f2a4e565f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', '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 13:00:05 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 13:00:05 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 13:00:05 INFO - Using env: {'DISPLAY': ':0', 13:00:05 INFO - 'HOME': '/home/cltbld', 13:00:05 INFO - 'LANG': 'en_US.UTF-8', 13:00:05 INFO - 'LANGUAGE': 'en_US:en', 13:00:05 INFO - 'LOGNAME': 'cltbld', 13:00:05 INFO - 'MAIL': '/var/mail/cltbld', 13:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:05 INFO - 'MOZ_NO_REMOTE': '1', 13:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:05 INFO - 'NO_EM_RESTART': '1', 13:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:05 INFO - 'PWD': '/builds/slave/test', 13:00:05 INFO - 'SHELL': '/bin/bash', 13:00:05 INFO - 'SHLVL': '1', 13:00:05 INFO - 'TERM': 'linux', 13:00:05 INFO - 'TMOUT': '86400', 13:00:05 INFO - 'USER': 'cltbld', 13:00:05 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 13:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:05 INFO - '_': '/tools/buildbot/bin/python'} 13:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:06 INFO - Running setup.py (path:/tmp/pip-axCBUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:06 INFO - Running setup.py (path:/tmp/pip-ud6OoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:06 INFO - Running setup.py (path:/tmp/pip-SzuYhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:06 INFO - Running setup.py (path:/tmp/pip-ctiYxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:06 INFO - Running setup.py (path:/tmp/pip-GFRQnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:06 INFO - Running setup.py (path:/tmp/pip-UXnUOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:06 INFO - Running setup.py (path:/tmp/pip-WgW13A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:06 INFO - Running setup.py (path:/tmp/pip-8YCN2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:06 INFO - Running setup.py (path:/tmp/pip-_aGQ03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:06 INFO - Running setup.py (path:/tmp/pip-MPC6pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:06 INFO - Running setup.py (path:/tmp/pip-yaX_4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:06 INFO - Running setup.py (path:/tmp/pip-8ae1dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:07 INFO - Running setup.py (path:/tmp/pip-QggGZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:07 INFO - Running setup.py (path:/tmp/pip-odLMvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:07 INFO - Running setup.py (path:/tmp/pip-mEBMvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:07 INFO - Running setup.py (path:/tmp/pip-l3NgQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:07 INFO - Running setup.py (path:/tmp/pip-0eoUDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:00:07 INFO - Running setup.py install for manifestparser 13:00:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:00:07 INFO - Running setup.py install for mozcrash 13:00:07 INFO - Running setup.py install for mozdebug 13:00:07 INFO - Running setup.py install for mozdevice 13:00:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:00:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:00:07 INFO - Running setup.py install for mozfile 13:00:07 INFO - Running setup.py install for mozhttpd 13:00:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Running setup.py install for mozinfo 13:00:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Running setup.py install for mozInstall 13:00:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Running setup.py install for mozleak 13:00:08 INFO - Running setup.py install for mozlog 13:00:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Running setup.py install for moznetwork 13:00:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Running setup.py install for mozprocess 13:00:08 INFO - Running setup.py install for mozprofile 13:00:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Running setup.py install for mozrunner 13:00:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:00:08 INFO - Running setup.py install for mozscreenshot 13:00:08 INFO - Running setup.py install for moztest 13:00:09 INFO - Running setup.py install for mozversion 13:00:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:00:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:00:09 INFO - Cleaning up... 13:00:09 INFO - Return code: 0 13:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:09 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 0x7f2a4e565f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', '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 13:00:09 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 13:00:09 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 13:00:09 INFO - Using env: {'DISPLAY': ':0', 13:00:09 INFO - 'HOME': '/home/cltbld', 13:00:09 INFO - 'LANG': 'en_US.UTF-8', 13:00:09 INFO - 'LANGUAGE': 'en_US:en', 13:00:09 INFO - 'LOGNAME': 'cltbld', 13:00:09 INFO - 'MAIL': '/var/mail/cltbld', 13:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:09 INFO - 'MOZ_NO_REMOTE': '1', 13:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:09 INFO - 'NO_EM_RESTART': '1', 13:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:09 INFO - 'PWD': '/builds/slave/test', 13:00:09 INFO - 'SHELL': '/bin/bash', 13:00:09 INFO - 'SHLVL': '1', 13:00:09 INFO - 'TERM': 'linux', 13:00:09 INFO - 'TMOUT': '86400', 13:00:09 INFO - 'USER': 'cltbld', 13:00:09 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 13:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:09 INFO - '_': '/tools/buildbot/bin/python'} 13:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:09 INFO - Running setup.py (path:/tmp/pip-5j3VOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:09 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)) 13:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:09 INFO - Running setup.py (path:/tmp/pip-5PPXzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:09 INFO - Running setup.py (path:/tmp/pip-OE95d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:09 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)) 13:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:09 INFO - Running setup.py (path:/tmp/pip-NECFfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:09 INFO - Running setup.py (path:/tmp/pip-exbX6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:09 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)) 13:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:09 INFO - Running setup.py (path:/tmp/pip-tFT0_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:09 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)) 13:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:09 INFO - Running setup.py (path:/tmp/pip-tmHjdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:09 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)) 13:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:09 INFO - Running setup.py (path:/tmp/pip-acDDum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:10 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)) 13:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:10 INFO - Running setup.py (path:/tmp/pip-0rL3T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:10 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)) 13:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:10 INFO - Running setup.py (path:/tmp/pip-zyPVDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:10 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)) 13:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:10 INFO - Running setup.py (path:/tmp/pip-BbRIyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:10 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)) 13:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:10 INFO - Running setup.py (path:/tmp/pip-p0AnzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:10 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)) 13:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:10 INFO - Running setup.py (path:/tmp/pip-rfViTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:10 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)) 13:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:10 INFO - Running setup.py (path:/tmp/pip-UcK1IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:10 INFO - Running setup.py (path:/tmp/pip-FSZIlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:10 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)) 13:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:10 INFO - Running setup.py (path:/tmp/pip-Ecb8cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:10 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)) 13:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:10 INFO - Running setup.py (path:/tmp/pip-anQacT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:10 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)) 13:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:00:10 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)) 13:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:00:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:00:10 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 13:00:10 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 13:00:10 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 13:00:10 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 13:00:10 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 13:00:10 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 13:00:12 INFO - Downloading blessings-1.6.tar.gz 13:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:00:12 INFO - Installing collected packages: blessings 13:00:12 INFO - Running setup.py install for blessings 13:00:12 INFO - Successfully installed blessings 13:00:12 INFO - Cleaning up... 13:00:12 INFO - Return code: 0 13:00:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:13 INFO - Reading from file tmpfile_stdout 13:00:13 INFO - Current package versions: 13:00:13 INFO - argparse == 1.2.1 13:00:13 INFO - blessings == 1.6 13:00:13 INFO - blobuploader == 1.2.4 13:00:13 INFO - docopt == 0.6.1 13:00:13 INFO - functools32 == 3.2.3-2 13:00:13 INFO - jsonschema == 2.5.1 13:00:13 INFO - manifestparser == 1.1 13:00:13 INFO - mozInstall == 1.12 13:00:13 INFO - mozcrash == 0.17 13:00:13 INFO - mozdebug == 0.1 13:00:13 INFO - mozdevice == 0.48 13:00:13 INFO - mozfile == 1.2 13:00:13 INFO - mozhttpd == 0.7 13:00:13 INFO - mozinfo == 0.9 13:00:13 INFO - mozleak == 0.1 13:00:13 INFO - mozlog == 3.4 13:00:13 INFO - moznetwork == 0.27 13:00:13 INFO - mozprocess == 0.23 13:00:13 INFO - mozprofile == 0.28 13:00:13 INFO - mozrunner == 6.12 13:00:13 INFO - mozscreenshot == 0.1 13:00:13 INFO - mozsystemmonitor == 0.3 13:00:13 INFO - moztest == 0.7 13:00:13 INFO - mozversion == 1.4 13:00:13 INFO - psutil == 3.1.1 13:00:13 INFO - requests == 1.2.3 13:00:13 INFO - wsgiref == 0.1.2 13:00:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:13 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 0x7f2a4e565f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', '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 13:00:13 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 13:00:13 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 13:00:13 INFO - Using env: {'DISPLAY': ':0', 13:00:13 INFO - 'HOME': '/home/cltbld', 13:00:13 INFO - 'LANG': 'en_US.UTF-8', 13:00:13 INFO - 'LANGUAGE': 'en_US:en', 13:00:13 INFO - 'LOGNAME': 'cltbld', 13:00:13 INFO - 'MAIL': '/var/mail/cltbld', 13:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:13 INFO - 'MOZ_NO_REMOTE': '1', 13:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:13 INFO - 'NO_EM_RESTART': '1', 13:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:13 INFO - 'PWD': '/builds/slave/test', 13:00:13 INFO - 'SHELL': '/bin/bash', 13:00:13 INFO - 'SHLVL': '1', 13:00:13 INFO - 'TERM': 'linux', 13:00:13 INFO - 'TMOUT': '86400', 13:00:13 INFO - 'USER': 'cltbld', 13:00:13 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 13:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:13 INFO - '_': '/tools/buildbot/bin/python'} 13:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:13 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)) 13:00:13 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)) 13:00:13 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)) 13:00:13 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)) 13:00:13 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)) 13:00:13 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)) 13:00:13 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)) 13:00:13 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)) 13:00:13 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)) 13:00:13 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)) 13:00:13 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)) 13:00:13 INFO - Cleaning up... 13:00:13 INFO - Return code: 0 13:00:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a4e565f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', '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 13:00:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:00:13 INFO - Using env: {'DISPLAY': ':0', 13:00:13 INFO - 'HOME': '/home/cltbld', 13:00:13 INFO - 'LANG': 'en_US.UTF-8', 13:00:13 INFO - 'LANGUAGE': 'en_US:en', 13:00:13 INFO - 'LOGNAME': 'cltbld', 13:00:13 INFO - 'MAIL': '/var/mail/cltbld', 13:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:13 INFO - 'MOZ_NO_REMOTE': '1', 13:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:13 INFO - 'NO_EM_RESTART': '1', 13:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:13 INFO - 'PWD': '/builds/slave/test', 13:00:13 INFO - 'SHELL': '/bin/bash', 13:00:13 INFO - 'SHLVL': '1', 13:00:13 INFO - 'TERM': 'linux', 13:00:13 INFO - 'TMOUT': '86400', 13:00:13 INFO - 'USER': 'cltbld', 13:00:13 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 13:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:13 INFO - '_': '/tools/buildbot/bin/python'} 13:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:00:13 INFO - Cleaning up... 13:00:13 INFO - Return code: 0 13:00:13 INFO - Running post-action listener: _resource_record_post_action 13:00:13 INFO - Running post-action listener: _start_resource_monitoring 13:00:13 INFO - Starting resource monitoring. 13:00:13 INFO - [mozharness: 2017-01-10 21:00:13.629561Z] Finished create-virtualenv step (success) 13:00:13 INFO - [mozharness: 2017-01-10 21:00:13.630060Z] Running install step. 13:00:13 INFO - Running pre-action listener: _resource_record_pre_action 13:00:13 INFO - Running main action method: install 13:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:13 INFO - Reading from file tmpfile_stdout 13:00:13 INFO - Detecting whether we're running mozinstall >=1.0... 13:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:00:13 INFO - Reading from file tmpfile_stdout 13:00:13 INFO - Output received: 13:00:13 INFO - Usage: mozinstall [options] installer 13:00:13 INFO - Options: 13:00:13 INFO - -h, --help show this help message and exit 13:00:13 INFO - -d DEST, --destination=DEST 13:00:13 INFO - Directory to install application into. [default: 13:00:13 INFO - "/builds/slave/test"] 13:00:13 INFO - --app=APP Application being installed. [default: firefox] 13:00:13 INFO - mkdir: /builds/slave/test/build/application 13:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:00:27 INFO - Reading from file tmpfile_stdout 13:00:27 INFO - Output received: 13:00:27 INFO - /builds/slave/test/build/application/firefox/firefox 13:00:27 INFO - Running post-action listener: _resource_record_post_action 13:00:27 INFO - [mozharness: 2017-01-10 21:00:27.411303Z] Finished install step (success) 13:00:27 INFO - [mozharness: 2017-01-10 21:00:27.411549Z] Running run-tests step. 13:00:27 INFO - Running pre-action listener: _resource_record_pre_action 13:00:27 INFO - Running main action method: run_tests 13:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:00:27 INFO - Python 2.7.3 13:00:27 INFO - Return code: 0 13:00:27 INFO - grabbing minidump binary from tooltool 13:00: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')]} 13:00:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d7f60>, '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 0x27d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:00:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:00:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:00:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:00:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:00:27 INFO - Return code: 0 13:00:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:00:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:00:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:00:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:00:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 13:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 13:00:27 INFO - Using env: {'DISPLAY': ':0', 13:00:27 INFO - 'HOME': '/home/cltbld', 13:00:27 INFO - 'LANG': 'en_US.UTF-8', 13:00:27 INFO - 'LANGUAGE': 'en_US:en', 13:00:27 INFO - 'LOGNAME': 'cltbld', 13:00:27 INFO - 'MAIL': '/var/mail/cltbld', 13:00:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:00:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:27 INFO - 'MOZ_NO_REMOTE': '1', 13:00:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:27 INFO - 'NO_EM_RESTART': '1', 13:00:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:27 INFO - 'PWD': '/builds/slave/test', 13:00:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:00:27 INFO - 'SHELL': '/bin/bash', 13:00:27 INFO - 'SHLVL': '1', 13:00:27 INFO - 'TERM': 'linux', 13:00:27 INFO - 'TMOUT': '86400', 13:00:27 INFO - 'USER': 'cltbld', 13:00:27 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176', 13:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:27 INFO - '_': '/tools/buildbot/bin/python'} 13:00:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 13:00:27 INFO - mozversion application_buildid: 20170110111805 13:00:27 INFO - mozversion application_changeset: 95d20a617288dde9faff91e847d414bb3403c157 13:00:27 INFO - mozversion application_display_name: Firefox 13:00:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:00:27 INFO - mozversion application_name: Firefox 13:00:27 INFO - mozversion application_remotingname: firefox 13:00:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:00:27 INFO - mozversion application_vendor: Mozilla 13:00:27 INFO - mozversion application_version: 51.0 13:00:27 INFO - mozversion platform_buildid: 20170110111805 13:00:27 INFO - mozversion platform_changeset: 95d20a617288dde9faff91e847d414bb3403c157 13:00:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:00:27 INFO - mozversion platform_version: 51.0 13:00:27 INFO - using testdate: 1484082027 13:00:27 INFO - actual date: 1484082027 13:00:27 INFO - starting webserver on 'localhost:36052' 13:00:27 INFO - SUITE-START | Running 2 tests 13:00:27 INFO - TEST-START | dromaeo_css 13:00:27 INFO - operating with platform_type : linux_ 13:00:27 INFO - Initialising browser for dromaeo_css test... 13:00:27 INFO - TEST-INFO | started process 10693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy7Rxqh/profile http://localhost:36052/getInfo.html) 13:00:31 INFO - PROCESS | 10693 | __metrics Screen width/height:1600/1200 13:00:31 INFO - PROCESS | 10693 | colorDepth:24 13:00:31 INFO - PROCESS | 10693 | Browser inner width/height: 1024/697 13:00:31 INFO - PROCESS | 10693 | __metrics 13:00:32 INFO - PROCESS | 10693 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:00:32 INFO - PROCESS | 10693 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:00:33 INFO - PROCESS | 10693 | console.error: PushService: 13:00:33 INFO - PROCESS | 10693 | stateChangeProcessEnqueue: Error transitioning state 13:00:33 INFO - PROCESS | 10693 | UnknownError 13:00:33 INFO - TEST-INFO | 10693: exit 0 13:00:33 INFO - Browser initialized. 13:00:33 INFO - Running cycle 1/1 for dromaeo_css test... 13:00:33 INFO - TEST-INFO | started process 10785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy7Rxqh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:00:45 INFO - PROCESS | 10785 | RSS: Main: 143511552 13:00:45 INFO - PROCESS | 10785 | 13:01:36 INFO - PROCESS | 10785 | 1484082096361 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] 13:03:45 INFO - PROCESS | 10785 | Cycle 1(1): loaded http://localhost:36052/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36052/tests/dromaeo/cssquery-ext.html) 13:03:46 INFO - PROCESS | 10785 | RSS: Main: 241004544 13:03:46 INFO - PROCESS | 10785 | 13:06:48 INFO - PROCESS | 10785 | Cycle 1(1): loaded http://localhost:36052/tests/dromaeo/cssquery-ext.html (next: http://localhost:36052/tests/dromaeo/cssquery-jquery.html) 13:06:49 INFO - PROCESS | 10785 | RSS: Main: 236822528 13:06:49 INFO - PROCESS | 10785 | 13:09:51 INFO - PROCESS | 10785 | Cycle 1(1): loaded http://localhost:36052/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36052/tests/dromaeo/cssquery-mootools.html) 13:09:51 INFO - PROCESS | 10785 | RSS: Main: 219553792 13:09:51 INFO - PROCESS | 10785 | 13:12:53 INFO - PROCESS | 10785 | Cycle 1(1): loaded http://localhost:36052/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36052/tests/dromaeo/cssquery-prototype.html) 13:12:54 INFO - PROCESS | 10785 | RSS: Main: 221364224 13:12:54 INFO - PROCESS | 10785 | 13:15:57 INFO - PROCESS | 10785 | Cycle 1(1): loaded http://localhost:36052/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36052/tests/dromaeo/cssquery-yui.html) 13:15:57 INFO - PROCESS | 10785 | RSS: Main: 178208768 13:15:57 INFO - PROCESS | 10785 | 13:19:00 INFO - PROCESS | 10785 | Cycle 1(1): loaded http://localhost:36052/tests/dromaeo/cssquery-yui.html (next: http://localhost:36052/tests/dromaeo/cssquery-dojo.html) 13:19:00 INFO - PROCESS | 10785 | RSS: Main: 266711040 13:19:00 INFO - PROCESS | 10785 | 13:19:00 INFO - PROCESS | 10785 | __start_tp_report 13:19:00 INFO - PROCESS | 10785 | _x_x_mozilla_page_load 13:19:00 INFO - PROCESS | 10785 | _x_x_mozilla_page_load_details 13:19:00 INFO - PROCESS | 10785 | |i|pagename|runs| 13:19:00 INFO - PROCESS | 10785 | |0;dojo.html;3121.968780312197;3162.22525481257;3177.0945280595033;3188.1073299476125;3209.2779124696945;5573.359063707675;5653.321601407826;5663.263775709157;5680.914786278199;5683.374828768832;5638.351589567201;5700;5709.115087161486;5720.399358067395;5724.484796368326;5129.256257842601;5151.922721159186;5192.896142077157;5202.245674377213;5246.790128394879;5082.771275292621;5241.030409374278;5253.658512196714;5260.27288039308;5286.973565132169;5055.5702765265;5074.847754567369;5108.489151084899;5161.561267292284;5170.689758614476;5114.769835357418;5158.38099428071;5160.2517634942915;5243.895122097537;5247.711375874325;5093.490650934914;5138.665986710852;5206.375234971828;5214.5306922376785;5240.213967904807;5467.6719396835915;5533.501984821385;5552.583556233299;5576.163575463673;5632.46491583303;5994.2806863176265;6015.729292181863;6021.578489505737;6110.725017374229;6112.327643959161;6141.877162456771;6142.508599312089;6146.200993870812;6158.291796443422;6158.815235542941;5526.005319042571;5553.305836770363;5576.358718747356;5612.214289999403;5614.663120212718;6177.2587289525545;6207.224096987877;6208.441240288395;6211.068339749074;6214.130021796952;5932.3474417814;5935.080062590219;5938.673372964528;5943.524518038546;5945.40545945402;5846.035404158351;5906.822795316061;5973.671448070398;6024.668643224577;6036.8188954331445;6091.360407157184;6094.146819445281;6099.054646529795;6100.328963813977;6123.357047509948;6061.242344706911;6107.786227482017;6117.847053823601;6136.29432615255;6140.293866205444;4539.341795439709;4577.29051996941;4578.450585929643;4613.192691279013;4679.274712419512;4106.835726570904;4137.648299894543;4164.83340666376;4169.812358443816;4178.247915375201;5798.10129429939;5801.245838041028;5803.593748437569;5810.477057064884;5813.622114562624;5949.375315591887;6003.489703375175;6029.216201893726;6117.877642447126;6127.969360153171;5734.197212390269;5809.128630705428;5814.680192589448;5819.970900145472;5844.444777746107;5294.92057619136;5298.470152984748;5299.761510732026;5302.522772950376;5304.204369344629;6106.114613381035;6147.200863887666;6232.376762323732;6280.780172693934;6294.3076261612105;5576.302962129734;6018.3680713524445;6104.32852386246;6172.197614310111;6195.380461953769;6326.145970293951;6328.303886572566;6335.366463353628;6337.366263373626;6348.333424990495;5796.76812927495;6031.035034394476;6040.84897877539;6044.607100538451;6046.455818976313;5912.881742365214;5997.310309314485;6014.2181516404335;6057.666828324308;6125.388069147376;5942.6731529766275;5982.940170598238;6000.21997140369;6000.399960003964;6028.186194863637;5973.253343332083;5979.043353063489;5980.730867110903;5981.252343457068;5985.461308482258;5697.287839020122;5796.449337312949;5816.040353341651;5823.388544202798;5863.560232982458;6018.909716354171;6021.488173505301;6031;6035.5473339500595;6052.727627256872;5746.569007324384;5882.5293976482635;5892.2929248488745;5897.292324921037;5897.439743224387 13:19:00 INFO - PROCESS | 10785 | |1;ext.html;578.1010528627985;619.8171539395878;639.8080575827256;642.2100815996324;648.1994736500423;33585.83207083964;36692.816535917285;36752.448713269325;36794;36869.446958295615;47017.294740578836;48164.51835481644;48620.51379486204;50874.23688644664;50973;9044.366894317383;9196;9198.264138868875;9199.402038867485;9258.861117083248;8443.366747493963;8638.827223455528;9244.306676999218;9310.581023853909;9333.719988400358;8608.48349099056;8672.52301123438;10999.725006874853;11247.718807029807;11250.718732031724;11078.612248571302;11133.777324453547;11134.554617815318;11138.3873886937;11141.442927853615;10567.10179634732;10627.14982801374;10630.787384252271;10631.149508039416;10643;44218.77890610559;44254.336184957254;44507.109857802665;44663.77668111671;44681.77659111684;3741.158239396114;3835.712321575893;3842.711796615265;3863.111484358585;3941.113249518864;33117;33728.32543349119;33821.83089084563;33975.83012084948;33998.320033599186;4671.743054132022;4686.859394218145;4704.082703872747;4728.881777955544;4775.403074615673;357776;359287;360013.19993400126;360491.9999999974;362436;62285;62464.37535624677;62616.37383626196;62736;62767.686161569814;40596;41208.38187427131;41435;43083.35374969378;64343.356566434675;17296.567585810455;17493.212805423787;17507.47477575675;17515.73726394105;17518.649627007642;12034.699132521582;12076.21504602198;12098.213616114925;12113.818292725617;12144.757104857854;20348.59302813965;20432.284870029478;20586.382408527767;20727;20788.064537095866;6137.570370074052;7244.565326080452;7244.637768111574;7288.453365997571;7457.179710231871;1050.4170185547096;1099.444780385916;1137.2266858536275;1176.6940595445076;1189.7856898526077;34706.132346691535;35136.64863351385;35174.296514069574;35189.824050880095;35446.822765886005;1172.6188988578576;1182.479708928069;1213.5631172777794;1217.2696382170805;1251.4618713953087;17741.37905173313;17934.730979035325;17954.19206135727;18077.36729214471;18100.45698629017;543583;549940;550896;551307;553335;38233.044173895876;38390.424143637865;38402.80798596045;38462;38469.6153038466;1308.7055412532295;1351.8377794664702;1361.3873756809278;1415.7239338329132;1429.0639631041684;30988.535171971987;33640.49539256864;34927.30145397027;35171.82414087913;35376.823115884254;51603.74198128985;52569.21146182734;52596.737016316205;52713;52767.472325276256;326271;326292;326541;326860;327055;26814.86592567025;27439;29370.706292936797;29590.260243494085;30523.08430747081;48891.26663099985;48967.75516122397;49005.75497122492;49401.50598493969;50219.497805021485;41185.79407102945;42400.954153712664;42473.36289955591;42911.35632965445;42924.57075429206;42393;42760.380584033715;46553.3017004752;46781.766091169324;48140;43293;43359.783201083796;43393.96362182665;44025.55974440215;44055.779721101186;36764.26471470609;38675.6132438672;39201.2159756809;39218.215635687695;39451.60548394479;29412.705872941;29802.552961706024;30010.84994575013;30133.547996780504;30158.69841301559 13:19:00 INFO - PROCESS | 10785 | |2;jquery.html;410.220580896297;418.2095838864548;426.3349175286553;431.66114600038964;444.65983522605194;18699.4390168295;19223.807761922395;20071.297504587343;20316.59366812663;20558;14145.318352059925;14663.266836658151;15139.167345795977;17757.91121044393;18091.09544522775;5793.942060579382;5848.415158484138;5856.707164641773;5905.350411454758;6048.909266361008;5881.8823623527505;5970.820875373724;5980.940190598104;5981.342052374235;5983.940160598404;5728.398518155596;5912.704364781765;5937.910931336012;5939.198208241897;5941.0494320908665;5701.173329867188;5881.088431293135;5915.881682366372;5918.822435326925;5923.940760592382;5256.053910296145;5305;5341.572674186055;5344.305240318772;5346.8395948121615;22852.77147228523;22957;22981.540369192524;23226.53546929052;23231.651525227135;2638.7625113739664;2717.415755612553;3107.974368458403;3183.2041989502623;3318.369509793132;14357.138571685628;14369.281535923163;14647.780283295759;14814.629634259121;15263.08421494714;1975.2000439821895;1993.9102740376572;2042.1320938601184;2070.0891607692565;2073.2225415469197;81492;83202.16797832005;84005.57997210036;84072.57963710204;85948.57025714894;9780.119789219005;10071.899281007243;10230.23273254509;10256;10276.845847312296;13920.791188132187;13961.511347102803;13992.16047037181;14013.5095271665;14038.649033774032;7632.274933881273;7750.302472777477;7892.763217103496;7983.5209887406945;7983.960080199678;7700.961495192488;7721.613919304013;7764;7904.920950790533;7909.7231596893835;4304.461942257218;4318.35224716295;4320.2223599751715;4324.502682191588;4439.067795762926;2033.6441122803747;2034.1964923854994;2060.6908963655274;2063.1128614695526;2092.3409126125525;973.8398895583875;990.8315586350337;1033.1992705653179;1037.2739082642029;1074.248026381536;19528.31650892212;19644.90177549132;19678.212871485266;19950.60098798016;20080.297189598296;997.997013001943;1004.1715584642699;1020.7652239984845;1059.2585190366774;1123.095907794217;10535.367877927196;10930.125589952784;10941.507632156412;11018.338899666045;11139.108871290277;395653;403742;517157;522337;556348;93236;106947;107724.46137769261;108454;110316;500.1272779000667;510.8799432133446;512.3569919750689;517.3145582103652;519.7790938850973;11256.831147532957;11795;16583.751243731112;17812.821871781118;17916.820831791516;43824.56175438205;45287.77356113198;46495.767521162175;46563;47454.76272618615;60991.69504152628;61303.693481532304;62272.68863655653;62545.37454625578;62783.6860815693;8852.911470885208;8881.955590222266;9075.183233509017;9213.907860921305;9522.190613797904;10506.947465262625;12986.285754283605;13088.672783180496;13399.799003015158;13429.26139062361;11317.660470185907;11989.040876729667;12001.879981200076;12088.818667720167;12478.438470268678;11873.346965916957;11965.581204657796;12064.698382540506;12277.20198187115;12620.368981550702;6701;9123.863142053007;12048.638540843789;12285.508579657071;12485.250884946568;9314.161725444743;9337.813243734952;9446.149846513847;9571.37786043905;9623.56693948788;10710.625128120479;11666.533338666359;12134.150609457607;12224.083193760325;12331.75336493283 13:19:00 INFO - PROCESS | 10785 | |3;mootools.html;1398.0842548130965;1494.6114010357303;1535.6928614277144;1694.7796786417764;1830.350225669888;8104.311133553648;8365.623546940387;8587.313014958803;8639.956800216007;8740.781480462983;9016.68441604544;9090.727278181648;9112.134347237003;9121.407108537956;9124.543772811367;2472.7774500294927;2484.5155194737035;2507.059852555292;2510.07127362876;2513.8114641401876;2412.1436889904094;2491.950160996779;2502.1117503286346;2510.0587279770084;2513.1455305196228;2371.537550177716;2394.6527753475734;2514.798816094717;2516.962245566318;2518.3452302401324;2382.2019623426086;2396.065534441569;2400.579898517761;2406.1818981546357;2406.3863714752715;2354.146870506989;2391.940201494959;2393.772591603812;2398.3404563744934;2401.2556107606697;8931.598078086501;8973.237274831647;9219.492927888963;9345.719628411158;9364.110409511153;5448.182772584105;5464.371597266326;5582.888342233173;5584.329880414336;5642.463965923231;3567.4292113261754;3620.873269435557;3688.133288677159;3707.2214834884708;3709.7032237421213;1200.1418985425375;1228.0912125027505;1233.5682511121126;1244.589285535771;1290.5741105435277;12842.614721558368;12983.221006739626;13001.414936327888;13042.54351097707;13054.282014489294;4698.9764025629165;4765.285207218875;4822.927656085161;4902.828401005948;4926.310316555685;10054.949725251474;10056.64801731936;10080.495975201211;10085.899141008642;10090.142337901214;5604.4395560444445;5606.915896261559;5607.52336051432;5612.410696876851;5623.325200975909;4583.54164583539;4707.552782485658;4999.75001249936;5123.923141152885;5232.633715639869;3964.306246406867;4046.826420338069;4069.267531844237;4124.257633625916;4143.3370660694745;1187.3647598534742;1194.3729541990524;1210.6368089573093;1226.3500344817262;1251.4806355362605;885.0883589902411;963.1909196275162;980.8871979722423;988.4810474500945;997.0976266478848;6192.752289908443;6294.748210071637;6340.144080549159;6434.227892652818;6441.066045423388;486.54751081493845;488.4065859980141;490.5315423770362;520.786477544205;530.8036026670079;4372.1692878353015;4377.912441751211;4394.648428125743;4430.756308403004;4558.6581006423985;11231.831522527169;11603.187776855539;11619.88380116205;11647.941760291144;11673.766524669629;10819.513121909376;11216.270942388719;11505.13711471643;11527.077833773446;11536.76926461466;8251.463654862535;8379.748607541662;8384.748457546284;8404;8429.241368276884;6414.198225221848;6522.967385163044;6549.541532092708;6605.57063790852;6702.530822842355;10234.6417875374;10549.367037977747;10672.092872105648;10680.732981675521;10806.405647689453;10182.592696292066;10328.225383096147;10643.414612196404;10836.349819010884;10843.132549396187;7474.2525747424825;7719;7859.960700196462;8170.346372290083;8369.288610467935;8814.779630509289;9092.863607045767;9099.090090990849;9105.681301154427;9141;7998.960005199937;8025.117237104031;8177.100518942792;8196.54918979462;8229;7852.097008844056;8007.319377852948;8063.435559510778;8154.83690326202;8232.50604963704;7330.193678695233;7379.963100184465;7402.148752893486;7405.222451642716;7538.849223015619;5199.792008319625;5415.160650099241;5511.53151982086;5526.088195447867;5635.774569017193;5393.865153371197;5503.449655034465;5547.084731019498;5578.470045345685;5646.943530564642 13:19:00 INFO - PROCESS | 10785 | |4;prototype.html;330.83458270864566;340.7240135490253;349.3031402352307;350.4445453955481;352.48713122406883;5297.4437684043105;5440.292761940952;5464.207689884965;5478.178273259008;5570.387257401682;5321.201819727034;5488;5492.313460817398;5494.835154945348;5532.7786888524515;4327.199468098396;4356;4366.476022877259;4372.540883207265;4377.912441751163;4208.55810139934;4312.654987600984;4334.718243314191;4384.333953097835;4388.407564978735;4317.438732964726;4327.9350809737725;4332.176886391576;4332.870013899588;4333.718308309965;4297.871063868089;4335.479742430913;4335.56644335567;4335.615411523665;4340.804663790137;3759.774413535197;3896.7467114637743;3915.882523524299;3917.4515567820526;3918.921621567581;5375.032494151052;5406.270153529263;5408.4050754416985;5409.188621706736;5439.592030597721;5013.799448022075;5018.899622007576;5041.588355260533;5042.495750424965;5045.167547354682;5473.67157970523;5758.942410575883;5801.866991824452;5802.187693722883;5814.592978491507;4292.313229883235;4293.677974151951;4297.290946993773;4298.183345164409;4308.159908817782;5917.101116022743;5952.7023648817385;6016.157737916695;6060.212172417601;6064.454199122056;4322.8703138905885;4360.738355698668;4394.67039971997;4422.84520041797;4423.823047078081;4446.688731788809;4456.3538286948215;4464.888377790517;4468.173387923244;4480.193565158303;4877.195262781673;4964.826231081895;4988.675736077216;5011.897382575828;5014.7994080236385;5586.128646903252;5812.82561523155;5871.031279838779;5871.853203669857;5873.706314684248;1464.1654257073578;1494.6039299585618;1524.7484165112853;1528.251156933117;1529.4035326222781;1019.2050200843354;1043.2488608202082;1065.2862582070031;1086.9945650271698;1088.6516314779194;5608.523275521545;5610.298712660918;5620.325560932714;5629.283068664096;5630.4369563043365;5898.351181370046;5906.852328691731;5916.526677865761;5929;5930.229070220844;5432.266644003009;5579.218909352694;5604.271444712162;5616.382197958222;5621.634593751393;2770.891643342639;2789.9537673372483;2793.6088947546955;2802.411493586329;2807.6663584797057;5047;5352.484332363782;5393.7572809223675;5399.624165367226;5412.350517937873;5270.472952704698;5301.628885978022;5302.284191634157;5307.681539107666;5381.6501927375375;5290.523852853262;5333.519983201453;5349;5357.464253574689;5394.757235924471;4888.731119788304;5261.8158364458595;5269.920951185812;5294.788208471618;5296.390915044819;5121.3342265506735;5155.664881782672;5164.3802743671;5164.896702065863;5246.921296180637;5248.632595718415;5299.867503312294;5331.733413329395;5364.973175134255;5402.594805389533;3784.99697580136;3930.1746633207345;3979.920401591894;3990.201959608148;4012.6589239914933;5162.380514338303;5215.869603259949;5230.921536176884;5670.858228544154;5811.27359080115;5657.236273103078;5734.770609175586;5865.706714664335;5883.911741323798;5896.174535564938;5803.9419605803405;5827.854303642443;5849.771547974973;5870.9412905870395;5883.882322353615;5597.720113994365;5753.539716822561;5779.537636989115;5785.247917770663;5804.82585522435;5800.419958004166;5853.326867410302;5861.1501332307425;5865.912011319919;5870.295564532284;5575.3688774339025;5596.496315331639;5661.264035675335;5707.372189059283;5719.771209151754 13:19:00 INFO - PROCESS | 10785 | |5;yui.html;736.105631657536;766.8811334243193;776.5030380556441;838.7316058861163;838.8951381077361;15167.848321516796;15889.920550397246;16055.759163612554;16077;16165.353385864566;14533.345999430025;14712.117272963604;14741.484048058293;14746.188959607218;14766.63083422915;704.3942209699654;722.4689852958072;821.757581513452;833.8749187621875;846.8899043124385;846.9618867150962;848.9235968762811;849.817289282804;850.2262940723942;852.6631980367752;880.2869675562814;892.9419587726777;894.552723638181;895.1764376773384;895.6238379880433;895.0378343280998;896.2202883491371;896.5248418338291;896.9372143949959;897.1118592593318;657.0341597851151;657.7500549791097;658.2824721054026;658.5982550644103;658.7299207324974;14706.264686765726;14712.55862324132;14724.33740481681;14727.70544589113;14743.189124598142;14882.627934301621;15148.924255378653;15412.152331621757;15721;15764.448244311508;12631.305278209695;12814.551490697873;12874.935625321907;13011.959043276514;13213.14114582549;3998.5601583825755;4016.357382818735;4033.838646454138;4079.938800917989;4103.651189648884;85415;85891.14108858893;86912.56543717241;87853.56073219593;88806;10834;12159.209651372632;12182.81725774114;12245.387730613611;12377.938110309571;20899.582008359746;21855;22021;22074;22082.227122050972;8312.916870831335;8328.541930193898;8406.705765298186;8543.914560854311;8565.229129378386;4983.401991761012;5107.795688172506;5115.079285728604;5130.692158470503;5157.249532983493;3602.765820221677;3715.554133503997;3724.217914237986;3725.2921944830937;3734.141147536082;538.4023733655639;617.71585070867;617.9598326108788;618.2056057965493;620.3951147631024;654.8362909272682;654.9586158008789;731.129955353128;748.296601194875;751.2750196060828;9666.613335466502;9689.806203876024;9961.900380996098;9970.30207885441;10048.849267260997;607.180306586114;614.8555089553952;653.6862306093102;658.3153520338794;677.8508728079814;4525.253333200051;4618.792154353062;4710.293455981561;4717.292406139107;4723;132786;139104;139987;142325;144559.2772036133;91335.08664913398;91742;95869;109762.45118774354;118577;56051.71974140103;56982.7150864243;59067.70466147642;82845.17154828495;83767.5811620938;9724.805503889742;9837.409755414697;10136.695899123039;10443.164546836082;10804.783904322027;39844;44895.77552112219;56318.71840640771;57073.85852282848;58382.4161758377;78725.60637196778;84215;85208.57395712982;86057;88635.55682221806;13614.622224221179;14160.291985400894;14232.146071235758;14337.928310358382;14446.494372697325;16242.918785405996;16316.918415407847;16413.17934103314;16780.51115343599;17409.738853916948;13951.232682202577;14219.50231741884;15536.378544858078;15543.84456155424;15571.37714491453;14592.92703536518;14772.63068423298;15644.921775391505;16026.839731602535;16057.518274451784;14367.497137600134;15380.69238615199;15525.767113493532;15864.127472989096;15887.68224635524;12163.452644630835;12285.877141228473;12290.324032177958;12834.16577922432;13512.459501620218;12169.513219471477;12248.203866748632;12329.136960413043;12330.938345308216;12356.3821808911 13:19:00 INFO - PROCESS | 10785 | __end_tp_report 13:19:00 INFO - PROCESS | 10785 | __start_cc_report 13:19:00 INFO - PROCESS | 10785 | _x_x_mozilla_cycle_collect,883 13:19:00 INFO - PROCESS | 10785 | __end_cc_report 13:19:00 INFO - PROCESS | 10785 | __startTimestamp1484083140706__endTimestamp 13:19:00 INFO - PROCESS | 10785 | 13:19:00 INFO - PROCESS | 10785 | ------- Summary: start ------- 13:19:00 INFO - PROCESS | 10785 | Number of tests: 6 13:19:00 INFO - PROCESS | 10785 | 13:19:00 INFO - PROCESS | 10785 | [#0] dojo.html Cycles:165 Average:5636.25 Median:5846.04 stddev:653.30 (11.2%) stddev-sans-first:624.82 13:19:00 INFO - PROCESS | 10785 | Values: 3122.0 3162.2 3177.1 3188.1 3209.3 5573.4 5653.3 5663.3 5680.9 5683.4 5638.4 5700.0 5709.1 5720.4 5724.5 5129.3 5151.9 5192.9 5202.2 5246.8 5082.8 5241.0 5253.7 5260.3 5287.0 5055.6 5074.8 5108.5 5161.6 5170.7 5114.8 5158.4 5160.3 5243.9 5247.7 5093.5 5138.7 5206.4 5214.5 5240.2 5467.7 5533.5 5552.6 5576.2 5632.5 5994.3 6015.7 6021.6 6110.7 6112.3 6141.9 6142.5 6146.2 6158.3 6158.8 5526.0 5553.3 5576.4 5612.2 5614.7 6177.3 6207.2 6208.4 6211.1 6214.1 5932.3 5935.1 5938.7 5943.5 5945.4 5846.0 5906.8 5973.7 6024.7 6036.8 6091.4 6094.1 6099.1 6100.3 6123.4 6061.2 6107.8 6117.8 6136.3 6140.3 4539.3 4577.3 4578.5 4613.2 4679.3 4106.8 4137.6 4164.8 4169.8 4178.2 5798.1 5801.2 5803.6 5810.5 5813.6 5949.4 6003.5 6029.2 6117.9 6128.0 5734.2 5809.1 5814.7 5820.0 5844.4 5294.9 5298.5 5299.8 5302.5 5304.2 6106.1 6147.2 6232.4 6280.8 6294.3 5576.3 6018.4 6104.3 6172.2 6195.4 6326.1 6328.3 6335.4 6337.4 6348.3 5796.8 6031.0 6040.8 6044.6 6046.5 5912.9 5997.3 6014.2 6057.7 6125.4 5942.7 5982.9 6000.2 6000.4 6028.2 5973.3 5979.0 5980.7 5981.3 5985.5 5697.3 5796.4 5816.0 5823.4 5863.6 6018.9 6021.5 6031.0 6035.5 6052.7 5746.6 5882.5 5892.3 5897.3 5897.4 13:19:00 INFO - PROCESS | 10785 | 13:19:00 INFO - PROCESS | 10785 | [#1] ext.html Cycles:180 Average:57907.30 Median:21034.38 stddev:112196.25 (533.4%) stddev-sans-first:112428.42 13:19:00 INFO - PROCESS | 10785 | Values: 578.1 619.8 639.8 642.2 648.2 33585.8 36692.8 36752.4 36794.0 36869.4 47017.3 48164.5 48620.5 50874.2 50973.0 9044.4 9196.0 9198.3 9199.4 9258.9 8443.4 8638.8 9244.3 9310.6 9333.7 8608.5 8672.5 10999.7 11247.7 11250.7 11078.6 11133.8 11134.6 11138.4 11141.4 10567.1 10627.1 10630.8 10631.1 10643.0 44218.8 44254.3 44507.1 44663.8 44681.8 3741.2 3835.7 3842.7 3863.1 3941.1 33117.0 33728.3 33821.8 33975.8 33998.3 4671.7 4686.9 4704.1 4728.9 4775.4 357776.0 359287.0 360013.2 360492.0 362436.0 62285.0 62464.4 62616.4 62736.0 62767.7 40596.0 41208.4 41435.0 43083.4 64343.4 17296.6 17493.2 17507.5 17515.7 17518.6 12034.7 12076.2 12098.2 12113.8 12144.8 20348.6 20432.3 20586.4 20727.0 20788.1 6137.6 7244.6 7244.6 7288.5 7457.2 1050.4 1099.4 1137.2 1176.7 1189.8 34706.1 35136.6 35174.3 35189.8 35446.8 1172.6 1182.5 1213.6 1217.3 1251.5 17741.4 17934.7 17954.2 18077.4 18100.5 543583.0 549940.0 550896.0 551307.0 553335.0 38233.0 38390.4 38402.8 38462.0 38469.6 1308.7 1351.8 1361.4 1415.7 1429.1 30988.5 33640.5 34927.3 35171.8 35376.8 51603.7 52569.2 52596.7 52713.0 52767.5 326271.0 326292.0 326541.0 326860.0 327055.0 26814.9 27439.0 29370.7 29590.3 30523.1 48891.3 48967.8 49005.8 49401.5 50219.5 41185.8 42401.0 42473.4 42911.4 42924.6 42393.0 42760.4 46553.3 46781.8 48140.0 43293.0 43359.8 43394.0 44025.6 44055.8 36764.3 38675.6 39201.2 39218.2 39451.6 29412.7 29802.6 30010.8 30133.5 30158.7 13:19:00 INFO - PROCESS | 10785 | 13:19:00 INFO - PROCESS | 10785 | [#2] jquery.html Cycles:180 Average:29336.25 Median:3145.59 stddev:80265.31 (2551.7%) stddev-sans-first:80461.09 13:19:00 INFO - PROCESS | 10785 | Values: 410.2 418.2 426.3 431.7 444.7 18699.4 19223.8 20071.3 20316.6 20558.0 14145.3 14663.3 15139.2 17757.9 18091.1 5793.9 5848.4 5856.7 5905.4 6048.9 5881.9 5970.8 5980.9 5981.3 5983.9 5728.4 5912.7 5937.9 5939.2 5941.0 5701.2 5881.1 5915.9 5918.8 5923.9 5256.1 5305.0 5341.6 5344.3 5346.8 22852.8 22957.0 22981.5 23226.5 23231.7 2638.8 2717.4 3108.0 3183.2 3318.4 14357.1 14369.3 14647.8 14814.6 15263.1 1975.2 1993.9 2042.1 2070.1 2073.2 81492.0 83202.2 84005.6 84072.6 85948.6 9780.1 10071.9 10230.2 10256.0 10276.8 13920.8 13961.5 13992.2 14013.5 14038.6 7632.3 7750.3 7892.8 7983.5 7984.0 7701.0 7721.6 7764.0 7904.9 7909.7 4304.5 4318.4 4320.2 4324.5 4439.1 2033.6 2034.2 2060.7 2063.1 2092.3 973.8 990.8 1033.2 1037.3 1074.2 19528.3 19644.9 19678.2 19950.6 20080.3 998.0 1004.2 1020.8 1059.3 1123.1 10535.4 10930.1 10941.5 11018.3 11139.1 395653.0 403742.0 517157.0 522337.0 556348.0 93236.0 106947.0 107724.5 108454.0 110316.0 500.1 510.9 512.4 517.3 519.8 11256.8 11795.0 16583.8 17812.8 17916.8 43824.6 45287.8 46495.8 46563.0 47454.8 60991.7 61303.7 62272.7 62545.4 62783.7 8852.9 8882.0 9075.2 9213.9 9522.2 10506.9 12986.3 13088.7 13399.8 13429.3 11317.7 11989.0 12001.9 12088.8 12478.4 11873.3 11965.6 12064.7 12277.2 12620.4 6701.0 9123.9 12048.6 12285.5 12485.3 9314.2 9337.8 9446.1 9571.4 9623.6 10710.6 11666.5 12134.2 12224.1 12331.8 13:19:00 INFO - PROCESS | 10785 | 13:19:00 INFO - PROCESS | 10785 | [#3] mootools.html Cycles:180 Average:6040.92 Median:487.48 stddev:3431.00 (703.8%) stddev-sans-first:3422.88 13:19:00 INFO - PROCESS | 10785 | Values: 1398.1 1494.6 1535.7 1694.8 1830.4 8104.3 8365.6 8587.3 8640.0 8740.8 9016.7 9090.7 9112.1 9121.4 9124.5 2472.8 2484.5 2507.1 2510.1 2513.8 2412.1 2492.0 2502.1 2510.1 2513.1 2371.5 2394.7 2514.8 2517.0 2518.3 2382.2 2396.1 2400.6 2406.2 2406.4 2354.1 2391.9 2393.8 2398.3 2401.3 8931.6 8973.2 9219.5 9345.7 9364.1 5448.2 5464.4 5582.9 5584.3 5642.5 3567.4 3620.9 3688.1 3707.2 3709.7 1200.1 1228.1 1233.6 1244.6 1290.6 12842.6 12983.2 13001.4 13042.5 13054.3 4699.0 4765.3 4822.9 4902.8 4926.3 10054.9 10056.6 10080.5 10085.9 10090.1 5604.4 5606.9 5607.5 5612.4 5623.3 4583.5 4707.6 4999.8 5123.9 5232.6 3964.3 4046.8 4069.3 4124.3 4143.3 1187.4 1194.4 1210.6 1226.4 1251.5 885.1 963.2 980.9 988.5 997.1 6192.8 6294.7 6340.1 6434.2 6441.1 486.5 488.4 490.5 520.8 530.8 4372.2 4377.9 4394.6 4430.8 4558.7 11231.8 11603.2 11619.9 11647.9 11673.8 10819.5 11216.3 11505.1 11527.1 11536.8 8251.5 8379.7 8384.7 8404.0 8429.2 6414.2 6523.0 6549.5 6605.6 6702.5 10234.6 10549.4 10672.1 10680.7 10806.4 10182.6 10328.2 10643.4 10836.3 10843.1 7474.3 7719.0 7860.0 8170.3 8369.3 8814.8 9092.9 9099.1 9105.7 9141.0 7999.0 8025.1 8177.1 8196.5 8229.0 7852.1 8007.3 8063.4 8154.8 8232.5 7330.2 7380.0 7402.1 7405.2 7538.8 5199.8 5415.2 5511.5 5526.1 5635.8 5393.9 5503.4 5547.1 5578.5 5646.9 13:19:00 INFO - PROCESS | 10785 | 13:19:00 INFO - PROCESS | 10785 | [#4] prototype.html Cycles:180 Average:4749.68 Median:5295.59 stddev:1353.42 (25.6%) stddev-sans-first:1315.95 13:19:00 INFO - PROCESS | 10785 | Values: 330.8 340.7 349.3 350.4 352.5 5297.4 5440.3 5464.2 5478.2 5570.4 5321.2 5488.0 5492.3 5494.8 5532.8 4327.2 4356.0 4366.5 4372.5 4377.9 4208.6 4312.7 4334.7 4384.3 4388.4 4317.4 4327.9 4332.2 4332.9 4333.7 4297.9 4335.5 4335.6 4335.6 4340.8 3759.8 3896.7 3915.9 3917.5 3918.9 5375.0 5406.3 5408.4 5409.2 5439.6 5013.8 5018.9 5041.6 5042.5 5045.2 5473.7 5758.9 5801.9 5802.2 5814.6 4292.3 4293.7 4297.3 4298.2 4308.2 5917.1 5952.7 6016.2 6060.2 6064.5 4322.9 4360.7 4394.7 4422.8 4423.8 4446.7 4456.4 4464.9 4468.2 4480.2 4877.2 4964.8 4988.7 5011.9 5014.8 5586.1 5812.8 5871.0 5871.9 5873.7 1464.2 1494.6 1524.7 1528.3 1529.4 1019.2 1043.2 1065.3 1087.0 1088.7 5608.5 5610.3 5620.3 5629.3 5630.4 5898.4 5906.9 5916.5 5929.0 5930.2 5432.3 5579.2 5604.3 5616.4 5621.6 2770.9 2790.0 2793.6 2802.4 2807.7 5047.0 5352.5 5393.8 5399.6 5412.4 5270.5 5301.6 5302.3 5307.7 5381.7 5290.5 5333.5 5349.0 5357.5 5394.8 4888.7 5261.8 5269.9 5294.8 5296.4 5121.3 5155.7 5164.4 5164.9 5246.9 5248.6 5299.9 5331.7 5365.0 5402.6 3785.0 3930.2 3979.9 3990.2 4012.7 5162.4 5215.9 5230.9 5670.9 5811.3 5657.2 5734.8 5865.7 5883.9 5896.2 5803.9 5827.9 5849.8 5870.9 5883.9 5597.7 5753.5 5779.5 5785.2 5804.8 5800.4 5853.3 5861.2 5865.9 5870.3 5575.4 5596.5 5661.3 5707.4 5719.8 13:19:00 INFO - PROCESS | 10785 | 13:19:00 INFO - PROCESS | 10785 | [#5] yui.html Cycles:180 Average:22039.92 Median:4091.79 stddev:32661.07 (798.2%) stddev-sans-first:32713.52 13:19:00 INFO - PROCESS | 10785 | Values: 736.1 766.9 776.5 838.7 838.9 15167.8 15889.9 16055.8 16077.0 16165.4 14533.3 14712.1 14741.5 14746.2 14766.6 704.4 722.5 821.8 833.9 846.9 847.0 848.9 849.8 850.2 852.7 880.3 892.9 894.6 895.2 895.6 895.0 896.2 896.5 896.9 897.1 657.0 657.8 658.3 658.6 658.7 14706.3 14712.6 14724.3 14727.7 14743.2 14882.6 15148.9 15412.2 15721.0 15764.4 12631.3 12814.6 12874.9 13012.0 13213.1 3998.6 4016.4 4033.8 4079.9 4103.7 85415.0 85891.1 86912.6 87853.6 88806.0 10834.0 12159.2 12182.8 12245.4 12377.9 20899.6 21855.0 22021.0 22074.0 22082.2 8312.9 8328.5 8406.7 8543.9 8565.2 4983.4 5107.8 5115.1 5130.7 5157.2 3602.8 3715.6 3724.2 3725.3 3734.1 538.4 617.7 618.0 618.2 620.4 654.8 655.0 731.1 748.3 751.3 9666.6 9689.8 9961.9 9970.3 10048.8 607.2 614.9 653.7 658.3 677.9 4525.3 4618.8 4710.3 4717.3 4723.0 132786.0 139104.0 139987.0 142325.0 144559.3 91335.1 91742.0 95869.0 109762.5 118577.0 56051.7 56982.7 59067.7 82845.2 83767.6 9724.8 9837.4 10136.7 10443.2 10804.8 39844.0 44895.8 56318.7 57073.9 58382.4 78725.6 84215.0 85208.6 86057.0 88635.6 13614.6 14160.3 14232.1 14337.9 14446.5 16242.9 16316.9 16413.2 16780.5 17409.7 13951.2 14219.5 15536.4 15543.8 15571.4 14592.9 14772.6 15644.9 16026.8 16057.5 14367.5 15380.7 15525.8 15864.1 15887.7 12163.5 12285.9 12290.3 12834.2 13512.5 12169.5 12248.2 12329.1 12330.9 12356.4 13:19:00 INFO - PROCESS | 10785 | -------- Summary: end -------- 13:19:00 INFO - PROCESS | 10785 | 13:19:01 INFO - TEST-INFO | 10785: exit 0 13:19:01 INFO - TEST-OK | dromaeo_css | took 1113736ms 13:19:01 INFO - TEST-START | kraken 13:19:01 INFO - operating with platform_type : linux_ 13:19:01 INFO - Initialising browser for kraken test... 13:19:01 INFO - TEST-INFO | started process 11097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt6FoUe/profile http://localhost:36052/getInfo.html) 13:19:05 INFO - PROCESS | 11097 | __metrics Screen width/height:1600/1200 13:19:05 INFO - PROCESS | 11097 | colorDepth:24 13:19:05 INFO - PROCESS | 11097 | Browser inner width/height: 1024/697 13:19:05 INFO - PROCESS | 11097 | __metrics 13:19:06 INFO - PROCESS | 11097 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:19:06 INFO - PROCESS | 11097 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:19:06 INFO - PROCESS | 11097 | console.error: PushService: 13:19:06 INFO - PROCESS | 11097 | stateChangeProcessEnqueue: Error transitioning state 13:19:06 INFO - PROCESS | 11097 | UnknownError 13:19:07 INFO - TEST-INFO | 11097: exit 0 13:19:07 INFO - Browser initialized. 13:19:07 INFO - Running cycle 1/1 for kraken test... 13:19:07 INFO - TEST-INFO | started process 11190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt6FoUe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:19 INFO - PROCESS | 11190 | RSS: Main: 143024128 13:19:19 INFO - PROCESS | 11190 | 13:19:21 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36052/tests/kraken/driver.html?testName=audio-beat-detection) 13:19:22 INFO - PROCESS | 11190 | RSS: Main: 187351040 13:19:22 INFO - PROCESS | 11190 | 13:19:24 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36052/tests/kraken/driver.html?testName=audio-dft) 13:19:25 INFO - PROCESS | 11190 | RSS: Main: 174739456 13:19:25 INFO - PROCESS | 11190 | 13:19:28 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36052/tests/kraken/driver.html?testName=audio-fft) 13:19:28 INFO - PROCESS | 11190 | RSS: Main: 266559488 13:19:28 INFO - PROCESS | 11190 | 13:19:30 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36052/tests/kraken/driver.html?testName=audio-oscillator) 13:19:31 INFO - PROCESS | 11190 | RSS: Main: 172183552 13:19:31 INFO - PROCESS | 11190 | 13:19:33 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36052/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:19:34 INFO - PROCESS | 11190 | RSS: Main: 174583808 13:19:34 INFO - PROCESS | 11190 | 13:19:37 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36052/tests/kraken/driver.html?testName=imaging-darkroom) 13:19:37 INFO - PROCESS | 11190 | RSS: Main: 210157568 13:19:37 INFO - PROCESS | 11190 | 13:19:41 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36052/tests/kraken/driver.html?testName=imaging-desaturate) 13:19:41 INFO - PROCESS | 11190 | RSS: Main: 209141760 13:19:41 INFO - PROCESS | 11190 | 13:19:44 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36052/tests/kraken/driver.html?testName=json-parse-financial) 13:19:45 INFO - PROCESS | 11190 | RSS: Main: 208633856 13:19:45 INFO - PROCESS | 11190 | 13:19:46 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36052/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:19:47 INFO - PROCESS | 11190 | RSS: Main: 170459136 13:19:47 INFO - PROCESS | 11190 | 13:19:48 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36052/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:19:49 INFO - PROCESS | 11190 | RSS: Main: 178331648 13:19:49 INFO - PROCESS | 11190 | 13:19:51 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36052/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:19:51 INFO - PROCESS | 11190 | RSS: Main: 187457536 13:19:51 INFO - PROCESS | 11190 | 13:19:54 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:19:55 INFO - PROCESS | 11190 | RSS: Main: 195170304 13:19:55 INFO - PROCESS | 11190 | 13:19:57 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:19:58 INFO - PROCESS | 11190 | RSS: Main: 191959040 13:19:58 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | Cycle 1(1): loaded http://localhost:36052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36052/tests/kraken/driver.html?testName=ai-astar) 13:20:00 INFO - PROCESS | 11190 | RSS: Main: 244269056 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | __start_tp_report 13:20:00 INFO - PROCESS | 11190 | _x_x_mozilla_page_load 13:20:00 INFO - PROCESS | 11190 | _x_x_mozilla_page_load_details 13:20:00 INFO - PROCESS | 11190 | |i|pagename|runs| 13:20:00 INFO - PROCESS | 11190 | |0;ai-astar;110;110;108;109;111;110;109;109;109;109 13:20:00 INFO - PROCESS | 11190 | |1;audio-beat-detection;143;118;117;148;117;122;119;116;143;119 13:20:00 INFO - PROCESS | 11190 | |2;audio-dft;160;161;161;160;160;162;161;160;162;161 13:20:00 INFO - PROCESS | 11190 | |3;audio-fft;75;77;75;104;76;76;76;77;97;76 13:20:00 INFO - PROCESS | 11190 | |4;audio-oscillator;83;81;118;83;81;82;104;81;81;111 13:20:00 INFO - PROCESS | 11190 | |5;imaging-gaussian-blur;116;117;117;116;116;117;117;117;116;116 13:20:00 INFO - PROCESS | 11190 | |6;imaging-darkroom;146;146;146;145;147;146;145;146;146;145 13:20:00 INFO - PROCESS | 11190 | |7;imaging-desaturate;95;95;95;96;95;95;97;95;95;95 13:20:00 INFO - PROCESS | 11190 | |8;json-parse-financial;50;54;51;51;51;50;55;50;51;50 13:20:00 INFO - PROCESS | 11190 | |9;json-stringify-tinderbox;58;59;58;58;58;59;60;58;58;58 13:20:00 INFO - PROCESS | 11190 | |10;stanford-crypto-aes;73;74;78;82;74;74;73;73;73;75 13:20:00 INFO - PROCESS | 11190 | |11;stanford-crypto-ccm;128;122;119;119;127;120;120;120;169;126 13:20:00 INFO - PROCESS | 11190 | |12;stanford-crypto-pbkdf2;152;149;151;150;151;151;155;159;153;155 13:20:00 INFO - PROCESS | 11190 | |13;stanford-crypto-sha256-iterative;61;61;63;60;62;62;63;61;60;61 13:20:00 INFO - PROCESS | 11190 | __end_tp_report 13:20:00 INFO - PROCESS | 11190 | __start_cc_report 13:20:00 INFO - PROCESS | 11190 | _x_x_mozilla_cycle_collect,1563 13:20:00 INFO - PROCESS | 11190 | __end_cc_report 13:20:00 INFO - PROCESS | 11190 | __startTimestamp1484083200253__endTimestamp 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | ------- Summary: start ------- 13:20:00 INFO - PROCESS | 11190 | Number of tests: 14 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#0] ai-astar Cycles:10 Average:109.40 Median:109.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 13:20:00 INFO - PROCESS | 11190 | Values: 110.0 110.0 108.0 109.0 111.0 110.0 109.0 109.0 109.0 109.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#1] audio-beat-detection Cycles:10 Average:126.20 Median:120.50 stddev:12.92 (10.7%) stddev-sans-first:12.19 13:20:00 INFO - PROCESS | 11190 | Values: 143.0 118.0 117.0 148.0 117.0 122.0 119.0 116.0 143.0 119.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 13:20:00 INFO - PROCESS | 11190 | Values: 160.0 161.0 161.0 160.0 160.0 162.0 161.0 160.0 162.0 161.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:10.48 (13.8%) stddev-sans-first:10.90 13:20:00 INFO - PROCESS | 11190 | Values: 75.0 77.0 75.0 104.0 76.0 76.0 76.0 77.0 97.0 76.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:81.00 stddev:14.55 (18.0%) stddev-sans-first:15.17 13:20:00 INFO - PROCESS | 11190 | Values: 83.0 81.0 118.0 83.0 81.0 82.0 104.0 81.0 81.0 111.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:20:00 INFO - PROCESS | 11190 | Values: 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:20:00 INFO - PROCESS | 11190 | Values: 146.0 146.0 146.0 145.0 147.0 146.0 145.0 146.0 146.0 145.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 13:20:00 INFO - PROCESS | 11190 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 97.0 95.0 95.0 95.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.77 (3.5%) stddev-sans-first:1.81 13:20:00 INFO - PROCESS | 11190 | Values: 50.0 54.0 51.0 51.0 51.0 50.0 55.0 50.0 51.0 50.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 13:20:00 INFO - PROCESS | 11190 | Values: 58.0 59.0 58.0 58.0 58.0 59.0 60.0 58.0 58.0 58.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:2.92 (4.0%) stddev-sans-first:3.02 13:20:00 INFO - PROCESS | 11190 | Values: 73.0 74.0 78.0 82.0 74.0 74.0 73.0 73.0 73.0 75.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:124.00 stddev:15.15 (12.2%) stddev-sans-first:16.07 13:20:00 INFO - PROCESS | 11190 | Values: 128.0 122.0 119.0 119.0 127.0 120.0 120.0 120.0 169.0 126.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:152.50 stddev:2.99 (2.0%) stddev-sans-first:3.16 13:20:00 INFO - PROCESS | 11190 | Values: 152.0 149.0 151.0 150.0 151.0 151.0 155.0 159.0 153.0 155.0 13:20:00 INFO - PROCESS | 11190 | 13:20:00 INFO - PROCESS | 11190 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.50 stddev:1.07 (1.7%) stddev-sans-first:1.13 13:20:00 INFO - PROCESS | 11190 | Values: 61.0 61.0 63.0 60.0 62.0 62.0 63.0 61.0 60.0 61.0 13:20:00 INFO - PROCESS | 11190 | -------- Summary: end -------- 13:20:00 INFO - PROCESS | 11190 | 13:20:01 INFO - TEST-INFO | 11190: exit 0 13:20:01 INFO - TEST-OK | kraken | took 59855ms 13:20:01 INFO - SUITE-END | took 1173s 13:20:01 INFO - Completed test suite (00:19:33) 13:20:01 INFO - javascript benchmark 13:20:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.968780312197, 3162.22525481257, 3177.0945280595033, 3188.1073299476125, 3209.2779124696945, 5573.359063707675, 5653.321601407826, 5663.263775709157, 5680.914786278199, 5683.374828768832, 5638.351589567201, 5700.0, 5709.115087161486, 5720.399358067395, 5724.484796368326, 5129.256257842601, 5151.922721159186, 5192.896142077157, 5202.245674377213, 5246.790128394879, 5082.771275292621, 5241.030409374278, 5253.658512196714, 5260.27288039308, 5286.973565132169, 5055.5702765265, 5074.847754567369, 5108.489151084899, 5161.561267292284, 5170.689758614476, 5114.769835357418, 5158.38099428071, 5160.2517634942915, 5243.895122097537, 5247.711375874325, 5093.490650934914, 5138.665986710852, 5206.375234971828, 5214.5306922376785, 5240.213967904807, 5467.6719396835915, 5533.501984821385, 5552.583556233299, 5576.163575463673, 5632.46491583303, 5994.2806863176265, 6015.729292181863, 6021.578489505737, 6110.725017374229, 6112.327643959161, 6141.877162456771, 6142.508599312089, 6146.200993870812, 6158.291796443422, 6158.815235542941, 5526.005319042571, 5553.305836770363, 5576.358718747356, 5612.214289999403, 5614.663120212718, 6177.2587289525545, 6207.224096987877, 6208.441240288395, 6211.068339749074, 6214.130021796952, 5932.3474417814, 5935.080062590219, 5938.673372964528, 5943.524518038546, 5945.40545945402, 5846.035404158351, 5906.822795316061, 5973.671448070398, 6024.668643224577, 6036.8188954331445, 6091.360407157184, 6094.146819445281, 6099.054646529795, 6100.328963813977, 6123.357047509948, 6061.242344706911, 6107.786227482017, 6117.847053823601, 6136.29432615255, 6140.293866205444, 4539.341795439709, 4577.29051996941, 4578.450585929643, 4613.192691279013, 4679.274712419512, 4106.835726570904, 4137.648299894543, 4164.83340666376, 4169.812358443816, 4178.247915375201, 5798.10129429939, 5801.245838041028, 5803.593748437569, 5810.477057064884, 5813.622114562624, 5949.375315591887, 6003.489703375175, 6029.216201893726, 6117.877642447126, 6127.969360153171, 5734.197212390269, 5809.128630705428, 5814.680192589448, 5819.970900145472, 5844.444777746107, 5294.92057619136, 5298.470152984748, 5299.761510732026, 5302.522772950376, 5304.204369344629, 6106.114613381035, 6147.200863887666, 6232.376762323732, 6280.780172693934, 6294.3076261612105, 5576.302962129734, 6018.3680713524445, 6104.32852386246, 6172.197614310111, 6195.380461953769, 6326.145970293951, 6328.303886572566, 6335.366463353628, 6337.366263373626, 6348.333424990495, 5796.76812927495, 6031.035034394476, 6040.84897877539, 6044.607100538451, 6046.455818976313, 5912.881742365214, 5997.310309314485, 6014.2181516404335, 6057.666828324308, 6125.388069147376, 5942.6731529766275, 5982.940170598238, 6000.21997140369, 6000.399960003964, 6028.186194863637, 5973.253343332083, 5979.043353063489, 5980.730867110903, 5981.252343457068, 5985.461308482258, 5697.287839020122, 5796.449337312949, 5816.040353341651, 5823.388544202798, 5863.560232982458, 6018.909716354171, 6021.488173505301, 6031.0, 6035.5473339500595, 6052.727627256872, 5746.569007324384, 5882.5293976482635, 5892.2929248488745, 5897.292324921037, 5897.439743224387], "value": 5590.5269543001195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.1010528627985, 619.8171539395878, 639.8080575827256, 642.2100815996324, 648.1994736500423, 33585.83207083964, 36692.816535917285, 36752.448713269325, 36794.0, 36869.446958295615, 47017.294740578836, 48164.51835481644, 48620.51379486204, 50874.23688644664, 50973.0, 9044.366894317383, 9196.0, 9198.264138868875, 9199.402038867485, 9258.861117083248, 8443.366747493963, 8638.827223455528, 9244.306676999218, 9310.581023853909, 9333.719988400358, 8608.48349099056, 8672.52301123438, 10999.725006874853, 11247.718807029807, 11250.718732031724, 11078.612248571302, 11133.777324453547, 11134.554617815318, 11138.3873886937, 11141.442927853615, 10567.10179634732, 10627.14982801374, 10630.787384252271, 10631.149508039416, 10643.0, 44218.77890610559, 44254.336184957254, 44507.109857802665, 44663.77668111671, 44681.77659111684, 3741.158239396114, 3835.712321575893, 3842.711796615265, 3863.111484358585, 3941.113249518864, 33117.0, 33728.32543349119, 33821.83089084563, 33975.83012084948, 33998.320033599186, 4671.743054132022, 4686.859394218145, 4704.082703872747, 4728.881777955544, 4775.403074615673, 357776.0, 359287.0, 360013.19993400126, 360491.9999999974, 362436.0, 62285.0, 62464.37535624677, 62616.37383626196, 62736.0, 62767.686161569814, 40596.0, 41208.38187427131, 41435.0, 43083.35374969378, 64343.356566434675, 17296.567585810455, 17493.212805423787, 17507.47477575675, 17515.73726394105, 17518.649627007642, 12034.699132521582, 12076.21504602198, 12098.213616114925, 12113.818292725617, 12144.757104857854, 20348.59302813965, 20432.284870029478, 20586.382408527767, 20727.0, 20788.064537095866, 6137.570370074052, 7244.565326080452, 7244.637768111574, 7288.453365997571, 7457.179710231871, 1050.4170185547096, 1099.444780385916, 1137.2266858536275, 1176.6940595445076, 1189.7856898526077, 34706.132346691535, 35136.64863351385, 35174.296514069574, 35189.824050880095, 35446.822765886005, 1172.6188988578576, 1182.479708928069, 1213.5631172777794, 1217.2696382170805, 1251.4618713953087, 17741.37905173313, 17934.730979035325, 17954.19206135727, 18077.36729214471, 18100.45698629017, 543583.0, 549940.0, 550896.0, 551307.0, 553335.0, 38233.044173895876, 38390.424143637865, 38402.80798596045, 38462.0, 38469.6153038466, 1308.7055412532295, 1351.8377794664702, 1361.3873756809278, 1415.7239338329132, 1429.0639631041684, 30988.535171971987, 33640.49539256864, 34927.30145397027, 35171.82414087913, 35376.823115884254, 51603.74198128985, 52569.21146182734, 52596.737016316205, 52713.0, 52767.472325276256, 326271.0, 326292.0, 326541.0, 326860.0, 327055.0, 26814.86592567025, 27439.0, 29370.706292936797, 29590.260243494085, 30523.08430747081, 48891.26663099985, 48967.75516122397, 49005.75497122492, 49401.50598493969, 50219.497805021485, 41185.79407102945, 42400.954153712664, 42473.36289955591, 42911.35632965445, 42924.57075429206, 42393.0, 42760.380584033715, 46553.3017004752, 46781.766091169324, 48140.0, 43293.0, 43359.783201083796, 43393.96362182665, 44025.55974440215, 44055.779721101186, 36764.26471470609, 38675.6132438672, 39201.2159756809, 39218.215635687695, 39451.60548394479, 29412.705872941, 29802.552961706024, 30010.84994575013, 30133.547996780504, 30158.69841301559], "value": 20578.322454424797, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.220580896297, 418.2095838864548, 426.3349175286553, 431.66114600038964, 444.65983522605194, 18699.4390168295, 19223.807761922395, 20071.297504587343, 20316.59366812663, 20558.0, 14145.318352059925, 14663.266836658151, 15139.167345795977, 17757.91121044393, 18091.09544522775, 5793.942060579382, 5848.415158484138, 5856.707164641773, 5905.350411454758, 6048.909266361008, 5881.8823623527505, 5970.820875373724, 5980.940190598104, 5981.342052374235, 5983.940160598404, 5728.398518155596, 5912.704364781765, 5937.910931336012, 5939.198208241897, 5941.0494320908665, 5701.173329867188, 5881.088431293135, 5915.881682366372, 5918.822435326925, 5923.940760592382, 5256.053910296145, 5305.0, 5341.572674186055, 5344.305240318772, 5346.8395948121615, 22852.77147228523, 22957.0, 22981.540369192524, 23226.53546929052, 23231.651525227135, 2638.7625113739664, 2717.415755612553, 3107.974368458403, 3183.2041989502623, 3318.369509793132, 14357.138571685628, 14369.281535923163, 14647.780283295759, 14814.629634259121, 15263.08421494714, 1975.2000439821895, 1993.9102740376572, 2042.1320938601184, 2070.0891607692565, 2073.2225415469197, 81492.0, 83202.16797832005, 84005.57997210036, 84072.57963710204, 85948.57025714894, 9780.119789219005, 10071.899281007243, 10230.23273254509, 10256.0, 10276.845847312296, 13920.791188132187, 13961.511347102803, 13992.16047037181, 14013.5095271665, 14038.649033774032, 7632.274933881273, 7750.302472777477, 7892.763217103496, 7983.5209887406945, 7983.960080199678, 7700.961495192488, 7721.613919304013, 7764.0, 7904.920950790533, 7909.7231596893835, 4304.461942257218, 4318.35224716295, 4320.2223599751715, 4324.502682191588, 4439.067795762926, 2033.6441122803747, 2034.1964923854994, 2060.6908963655274, 2063.1128614695526, 2092.3409126125525, 973.8398895583875, 990.8315586350337, 1033.1992705653179, 1037.2739082642029, 1074.248026381536, 19528.31650892212, 19644.90177549132, 19678.212871485266, 19950.60098798016, 20080.297189598296, 997.997013001943, 1004.1715584642699, 1020.7652239984845, 1059.2585190366774, 1123.095907794217, 10535.367877927196, 10930.125589952784, 10941.507632156412, 11018.338899666045, 11139.108871290277, 395653.0, 403742.0, 517157.0, 522337.0, 556348.0, 93236.0, 106947.0, 107724.46137769261, 108454.0, 110316.0, 500.1272779000667, 510.8799432133446, 512.3569919750689, 517.3145582103652, 519.7790938850973, 11256.831147532957, 11795.0, 16583.751243731112, 17812.821871781118, 17916.820831791516, 43824.56175438205, 45287.77356113198, 46495.767521162175, 46563.0, 47454.76272618615, 60991.69504152628, 61303.693481532304, 62272.68863655653, 62545.37454625578, 62783.6860815693, 8852.911470885208, 8881.955590222266, 9075.183233509017, 9213.907860921305, 9522.190613797904, 10506.947465262625, 12986.285754283605, 13088.672783180496, 13399.799003015158, 13429.26139062361, 11317.660470185907, 11989.040876729667, 12001.879981200076, 12088.818667720167, 12478.438470268678, 11873.346965916957, 11965.581204657796, 12064.698382540506, 12277.20198187115, 12620.368981550702, 6701.0, 9123.863142053007, 12048.638540843789, 12285.508579657071, 12485.250884946568, 9314.161725444743, 9337.813243734952, 9446.149846513847, 9571.37786043905, 9623.56693948788, 10710.625128120479, 11666.533338666359, 12134.150609457607, 12224.083193760325, 12331.75336493283], "value": 9242.755559773632, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.0842548130965, 1494.6114010357303, 1535.6928614277144, 1694.7796786417764, 1830.350225669888, 8104.311133553648, 8365.623546940387, 8587.313014958803, 8639.956800216007, 8740.781480462983, 9016.68441604544, 9090.727278181648, 9112.134347237003, 9121.407108537956, 9124.543772811367, 2472.7774500294927, 2484.5155194737035, 2507.059852555292, 2510.07127362876, 2513.8114641401876, 2412.1436889904094, 2491.950160996779, 2502.1117503286346, 2510.0587279770084, 2513.1455305196228, 2371.537550177716, 2394.6527753475734, 2514.798816094717, 2516.962245566318, 2518.3452302401324, 2382.2019623426086, 2396.065534441569, 2400.579898517761, 2406.1818981546357, 2406.3863714752715, 2354.146870506989, 2391.940201494959, 2393.772591603812, 2398.3404563744934, 2401.2556107606697, 8931.598078086501, 8973.237274831647, 9219.492927888963, 9345.719628411158, 9364.110409511153, 5448.182772584105, 5464.371597266326, 5582.888342233173, 5584.329880414336, 5642.463965923231, 3567.4292113261754, 3620.873269435557, 3688.133288677159, 3707.2214834884708, 3709.7032237421213, 1200.1418985425375, 1228.0912125027505, 1233.5682511121126, 1244.589285535771, 1290.5741105435277, 12842.614721558368, 12983.221006739626, 13001.414936327888, 13042.54351097707, 13054.282014489294, 4698.9764025629165, 4765.285207218875, 4822.927656085161, 4902.828401005948, 4926.310316555685, 10054.949725251474, 10056.64801731936, 10080.495975201211, 10085.899141008642, 10090.142337901214, 5604.4395560444445, 5606.915896261559, 5607.52336051432, 5612.410696876851, 5623.325200975909, 4583.54164583539, 4707.552782485658, 4999.75001249936, 5123.923141152885, 5232.633715639869, 3964.306246406867, 4046.826420338069, 4069.267531844237, 4124.257633625916, 4143.3370660694745, 1187.3647598534742, 1194.3729541990524, 1210.6368089573093, 1226.3500344817262, 1251.4806355362605, 885.0883589902411, 963.1909196275162, 980.8871979722423, 988.4810474500945, 997.0976266478848, 6192.752289908443, 6294.748210071637, 6340.144080549159, 6434.227892652818, 6441.066045423388, 486.54751081493845, 488.4065859980141, 490.5315423770362, 520.786477544205, 530.8036026670079, 4372.1692878353015, 4377.912441751211, 4394.648428125743, 4430.756308403004, 4558.6581006423985, 11231.831522527169, 11603.187776855539, 11619.88380116205, 11647.941760291144, 11673.766524669629, 10819.513121909376, 11216.270942388719, 11505.13711471643, 11527.077833773446, 11536.76926461466, 8251.463654862535, 8379.748607541662, 8384.748457546284, 8404.0, 8429.241368276884, 6414.198225221848, 6522.967385163044, 6549.541532092708, 6605.57063790852, 6702.530822842355, 10234.6417875374, 10549.367037977747, 10672.092872105648, 10680.732981675521, 10806.405647689453, 10182.592696292066, 10328.225383096147, 10643.414612196404, 10836.349819010884, 10843.132549396187, 7474.2525747424825, 7719.0, 7859.960700196462, 8170.346372290083, 8369.288610467935, 8814.779630509289, 9092.863607045767, 9099.090090990849, 9105.681301154427, 9141.0, 7998.960005199937, 8025.117237104031, 8177.100518942792, 8196.54918979462, 8229.0, 7852.097008844056, 8007.319377852948, 8063.435559510778, 8154.83690326202, 8232.50604963704, 7330.193678695233, 7379.963100184465, 7402.148752893486, 7405.222451642716, 7538.849223015619, 5199.792008319625, 5415.160650099241, 5511.53151982086, 5526.088195447867, 5635.774569017193, 5393.865153371197, 5503.449655034465, 5547.084731019498, 5578.470045345685, 5646.943530564642], "value": 4759.30456960786, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.83458270864566, 340.7240135490253, 349.3031402352307, 350.4445453955481, 352.48713122406883, 5297.4437684043105, 5440.292761940952, 5464.207689884965, 5478.178273259008, 5570.387257401682, 5321.201819727034, 5488.0, 5492.313460817398, 5494.835154945348, 5532.7786888524515, 4327.199468098396, 4356.0, 4366.476022877259, 4372.540883207265, 4377.912441751163, 4208.55810139934, 4312.654987600984, 4334.718243314191, 4384.333953097835, 4388.407564978735, 4317.438732964726, 4327.9350809737725, 4332.176886391576, 4332.870013899588, 4333.718308309965, 4297.871063868089, 4335.479742430913, 4335.56644335567, 4335.615411523665, 4340.804663790137, 3759.774413535197, 3896.7467114637743, 3915.882523524299, 3917.4515567820526, 3918.921621567581, 5375.032494151052, 5406.270153529263, 5408.4050754416985, 5409.188621706736, 5439.592030597721, 5013.799448022075, 5018.899622007576, 5041.588355260533, 5042.495750424965, 5045.167547354682, 5473.67157970523, 5758.942410575883, 5801.866991824452, 5802.187693722883, 5814.592978491507, 4292.313229883235, 4293.677974151951, 4297.290946993773, 4298.183345164409, 4308.159908817782, 5917.101116022743, 5952.7023648817385, 6016.157737916695, 6060.212172417601, 6064.454199122056, 4322.8703138905885, 4360.738355698668, 4394.67039971997, 4422.84520041797, 4423.823047078081, 4446.688731788809, 4456.3538286948215, 4464.888377790517, 4468.173387923244, 4480.193565158303, 4877.195262781673, 4964.826231081895, 4988.675736077216, 5011.897382575828, 5014.7994080236385, 5586.128646903252, 5812.82561523155, 5871.031279838779, 5871.853203669857, 5873.706314684248, 1464.1654257073578, 1494.6039299585618, 1524.7484165112853, 1528.251156933117, 1529.4035326222781, 1019.2050200843354, 1043.2488608202082, 1065.2862582070031, 1086.9945650271698, 1088.6516314779194, 5608.523275521545, 5610.298712660918, 5620.325560932714, 5629.283068664096, 5630.4369563043365, 5898.351181370046, 5906.852328691731, 5916.526677865761, 5929.0, 5930.229070220844, 5432.266644003009, 5579.218909352694, 5604.271444712162, 5616.382197958222, 5621.634593751393, 2770.891643342639, 2789.9537673372483, 2793.6088947546955, 2802.411493586329, 2807.6663584797057, 5047.0, 5352.484332363782, 5393.7572809223675, 5399.624165367226, 5412.350517937873, 5270.472952704698, 5301.628885978022, 5302.284191634157, 5307.681539107666, 5381.6501927375375, 5290.523852853262, 5333.519983201453, 5349.0, 5357.464253574689, 5394.757235924471, 4888.731119788304, 5261.8158364458595, 5269.920951185812, 5294.788208471618, 5296.390915044819, 5121.3342265506735, 5155.664881782672, 5164.3802743671, 5164.896702065863, 5246.921296180637, 5248.632595718415, 5299.867503312294, 5331.733413329395, 5364.973175134255, 5402.594805389533, 3784.99697580136, 3930.1746633207345, 3979.920401591894, 3990.201959608148, 4012.6589239914933, 5162.380514338303, 5215.869603259949, 5230.921536176884, 5670.858228544154, 5811.27359080115, 5657.236273103078, 5734.770609175586, 5865.706714664335, 5883.911741323798, 5896.174535564938, 5803.9419605803405, 5827.854303642443, 5849.771547974973, 5870.9412905870395, 5883.882322353615, 5597.720113994365, 5753.539716822561, 5779.537636989115, 5785.247917770663, 5804.82585522435, 5800.419958004166, 5853.326867410302, 5861.1501332307425, 5865.912011319919, 5870.295564532284, 5575.3688774339025, 5596.496315331639, 5661.264035675335, 5707.372189059283, 5719.771209151754], "value": 4325.909925896438, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.105631657536, 766.8811334243193, 776.5030380556441, 838.7316058861163, 838.8951381077361, 15167.848321516796, 15889.920550397246, 16055.759163612554, 16077.0, 16165.353385864566, 14533.345999430025, 14712.117272963604, 14741.484048058293, 14746.188959607218, 14766.63083422915, 704.3942209699654, 722.4689852958072, 821.757581513452, 833.8749187621875, 846.8899043124385, 846.9618867150962, 848.9235968762811, 849.817289282804, 850.2262940723942, 852.6631980367752, 880.2869675562814, 892.9419587726777, 894.552723638181, 895.1764376773384, 895.6238379880433, 895.0378343280998, 896.2202883491371, 896.5248418338291, 896.9372143949959, 897.1118592593318, 657.0341597851151, 657.7500549791097, 658.2824721054026, 658.5982550644103, 658.7299207324974, 14706.264686765726, 14712.55862324132, 14724.33740481681, 14727.70544589113, 14743.189124598142, 14882.627934301621, 15148.924255378653, 15412.152331621757, 15721.0, 15764.448244311508, 12631.305278209695, 12814.551490697873, 12874.935625321907, 13011.959043276514, 13213.14114582549, 3998.5601583825755, 4016.357382818735, 4033.838646454138, 4079.938800917989, 4103.651189648884, 85415.0, 85891.14108858893, 86912.56543717241, 87853.56073219593, 88806.0, 10834.0, 12159.209651372632, 12182.81725774114, 12245.387730613611, 12377.938110309571, 20899.582008359746, 21855.0, 22021.0, 22074.0, 22082.227122050972, 8312.916870831335, 8328.541930193898, 8406.705765298186, 8543.914560854311, 8565.229129378386, 4983.401991761012, 5107.795688172506, 5115.079285728604, 5130.692158470503, 5157.249532983493, 3602.765820221677, 3715.554133503997, 3724.217914237986, 3725.2921944830937, 3734.141147536082, 538.4023733655639, 617.71585070867, 617.9598326108788, 618.2056057965493, 620.3951147631024, 654.8362909272682, 654.9586158008789, 731.129955353128, 748.296601194875, 751.2750196060828, 9666.613335466502, 9689.806203876024, 9961.900380996098, 9970.30207885441, 10048.849267260997, 607.180306586114, 614.8555089553952, 653.6862306093102, 658.3153520338794, 677.8508728079814, 4525.253333200051, 4618.792154353062, 4710.293455981561, 4717.292406139107, 4723.0, 132786.0, 139104.0, 139987.0, 142325.0, 144559.2772036133, 91335.08664913398, 91742.0, 95869.0, 109762.45118774354, 118577.0, 56051.71974140103, 56982.7150864243, 59067.70466147642, 82845.17154828495, 83767.5811620938, 9724.805503889742, 9837.409755414697, 10136.695899123039, 10443.164546836082, 10804.783904322027, 39844.0, 44895.77552112219, 56318.71840640771, 57073.85852282848, 58382.4161758377, 78725.60637196778, 84215.0, 85208.57395712982, 86057.0, 88635.55682221806, 13614.622224221179, 14160.291985400894, 14232.146071235758, 14337.928310358382, 14446.494372697325, 16242.918785405996, 16316.918415407847, 16413.17934103314, 16780.51115343599, 17409.738853916948, 13951.232682202577, 14219.50231741884, 15536.378544858078, 15543.84456155424, 15571.37714491453, 14592.92703536518, 14772.63068423298, 15644.921775391505, 16026.839731602535, 16057.518274451784, 14367.497137600134, 15380.69238615199, 15525.767113493532, 15864.127472989096, 15887.68224635524, 12163.452644630835, 12285.877141228473, 12290.324032177958, 12834.16577922432, 13512.459501620218, 12169.513219471477, 12248.203866748632, 12329.136960413043, 12330.938345308216, 12356.3821808911], "value": 7886.4588677802485, "unit": "score"}], "name": "dromaeo_css", "value": 7462.2262618282975, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 108.0, 109.0, 111.0, 110.0, 109.0, 109.0, 109.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 117.0, 148.0, 117.0, 122.0, 119.0, 116.0, 143.0, 119.0], "value": 126.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 160.0, 162.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 104.0, 76.0, 76.0, 76.0, 77.0, 97.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 118.0, 83.0, 81.0, 82.0, 104.0, 81.0, 81.0, 111.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 54.0, 51.0, 51.0, 51.0, 50.0, 55.0, 50.0, 51.0, 50.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 60.0, 58.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 78.0, 82.0, 74.0, 74.0, 73.0, 73.0, 73.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 122.0, 119.0, 119.0, 127.0, 120.0, 120.0, 120.0, 169.0, 126.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 151.0, 150.0, 151.0, 151.0, 155.0, 159.0, 153.0, 155.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 63.0, 60.0, 62.0, 62.0, 63.0, 61.0, 60.0, 61.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1451.0000000000002, "alertThreshold": 2.0}]} 13:20:01 INFO - Return code: 0 13:20:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:20:01 INFO - # TBPL SUCCESS # 13:20:01 INFO - Running post-action listener: _resource_record_post_action 13:20:01 INFO - [mozharness: 2017-01-10 21:20:01.556529Z] Finished run-tests step (success) 13:20:01 INFO - Running post-run listener: _resource_record_post_run 13:20:01 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 1732608; Write bytes: 329859072; Read time: 40; Write time: 267572 13:20:01 INFO - TinderboxPrint: CPU usage
13.0% 13:20:01 INFO - TinderboxPrint: I/O read bytes / time
1,732,608 / 40 13:20:01 INFO - TinderboxPrint: I/O write bytes / time
329,859,072 / 267,572 13:20:01 INFO - TinderboxPrint: CPU idle
8,244.6 (87.0%) 13:20:01 INFO - TinderboxPrint: CPU user
1,185.7 (12.5%) 13:20:01 INFO - TinderboxPrint: Swap in / out
0 / 0 13:20:01 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 111788032; Read time: 0; Write time: 101592 13:20:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 218071040; Read time: 0; Write time: 165980 13:20:02 INFO - Running post-run listener: _upload_blobber_files 13:20:02 INFO - Blob upload gear active. 13:20:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:20:02 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 13:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:20:02 INFO - (blobuploader) - INFO - Open directory for files ... 13:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:03 INFO - (blobuploader) - INFO - Done attempting. 13:20:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:20:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:07 INFO - (blobuploader) - INFO - Done attempting. 13:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:08 INFO - (blobuploader) - INFO - Done attempting. 13:20:08 INFO - (blobuploader) - INFO - Iteration through files over. 13:20:08 INFO - Return code: 0 13:20:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:20:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:20:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00c38166a65e8f64af40c8ebd23dc6c9bed1a256822b525e37d17eac474663ee5d9e08c956f58424f98df0b499422eaf0aa8bdfb8fb07f77b0c58de110d345e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6626fbc8dad1082f66ca2768a92269a252f1cbf3a256c53f826c6563957bfbfd2763c848de68001f35646651d1a79fcd126c503f3007acfa8a3a11ae53f0a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bb7d9d430afecc5aa13845c93c92376ae79b9b184cb2c16e8c881db32ed8939895df66baad49a282ddeae85b4395dd6902d400442e138be826df4ac32724262"} 13:20:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:20:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:20:08 INFO - Contents: 13:20:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00c38166a65e8f64af40c8ebd23dc6c9bed1a256822b525e37d17eac474663ee5d9e08c956f58424f98df0b499422eaf0aa8bdfb8fb07f77b0c58de110d345e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6626fbc8dad1082f66ca2768a92269a252f1cbf3a256c53f826c6563957bfbfd2763c848de68001f35646651d1a79fcd126c503f3007acfa8a3a11ae53f0a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bb7d9d430afecc5aa13845c93c92376ae79b9b184cb2c16e8c881db32ed8939895df66baad49a282ddeae85b4395dd6902d400442e138be826df4ac32724262"} 13:20:08 INFO - Running post-run listener: copy_logs_to_upload_dir 13:20:08 INFO - Copying logs to upload dir... 13:20:08 INFO - mkdir: /builds/slave/test/build/upload/logs 13:20:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.707136 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-10 13:20:07.634192) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 13:20:07.637930) ========= 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=ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00c38166a65e8f64af40c8ebd23dc6c9bed1a256822b525e37d17eac474663ee5d9e08c956f58424f98df0b499422eaf0aa8bdfb8fb07f77b0c58de110d345e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6626fbc8dad1082f66ca2768a92269a252f1cbf3a256c53f826c6563957bfbfd2763c848de68001f35646651d1a79fcd126c503f3007acfa8a3a11ae53f0a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bb7d9d430afecc5aa13845c93c92376ae79b9b184cb2c16e8c881db32ed8939895df66baad49a282ddeae85b4395dd6902d400442e138be826df4ac32724262"} build_url:https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011531 build_url: 'https://queue.taskcluster.net/v1/task/ISOwDQ0LTtSASPTJg0Tj7g/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e00c38166a65e8f64af40c8ebd23dc6c9bed1a256822b525e37d17eac474663ee5d9e08c956f58424f98df0b499422eaf0aa8bdfb8fb07f77b0c58de110d345e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6626fbc8dad1082f66ca2768a92269a252f1cbf3a256c53f826c6563957bfbfd2763c848de68001f35646651d1a79fcd126c503f3007acfa8a3a11ae53f0a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bb7d9d430afecc5aa13845c93c92376ae79b9b184cb2c16e8c881db32ed8939895df66baad49a282ddeae85b4395dd6902d400442e138be826df4ac32724262"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 13:20:07.662580) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 13:20:07.662868) ========= 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=ba164b0a7b0ec7655860e956000001c1-1484081214.348080-417676176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 13:20:07.748022) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 13:20:07.748312) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 13:20:07.748596) ========= ========= Total master_lag: 0.39 =========