builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1483639398.68 results: success (0) buildid: 20170105081520 builduid: 2f14b02bc5ec408b882de18ca79cd87c revision: faa5342a058268bdba1b87b65e56a55d51522bbf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:18.682797) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:18.683541) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:18.684004) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:18.701136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:18.701874) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-05 10:03:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-01-05 10:03:19 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157527 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:18.900205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:18.900610) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016636 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:18.951246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:18.951676) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev faa5342a058268bdba1b87b65e56a55d51522bbf --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 faa5342a058268bdba1b87b65e56a55d51522bbf --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=56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-05 10:03:19,294 truncating revision to first 12 chars 2017-01-05 10:03:19,294 Setting DEBUG logging. 2017-01-05 10:03:19,294 attempt 1/10 2017-01-05 10:03:19,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/faa5342a0582?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 10:03:19,733 unpacking tar archive at: mozilla-beta-faa5342a0582/testing/mozharness/ program finished with exit code 0 elapsedTime=0.758515 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:19.729055) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:19.729882) ========= script_repo_revision: faa5342a058268bdba1b87b65e56a55d51522bbf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:19.730776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:19.731404) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 10:03:19.744621) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-05 10:03:19.745197) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:03:20 INFO - MultiFileLogger online at 20170105 10:03:20 in /builds/slave/test 10:03:20 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 10:03:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:03:20 INFO - {'append_to_log': False, 10:03:20 INFO - 'base_work_dir': '/builds/slave/test', 10:03:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:03:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:03:20 INFO - 'branch': 'Mozilla-Beta', 10:03:20 INFO - 'buildbot_json_path': 'buildprops.json', 10:03:20 INFO - 'config_files': ('talos/linux_config.py',), 10:03:20 INFO - 'default_actions': ('clobber', 10:03:20 INFO - 'read-buildbot-config', 10:03:20 INFO - 'download-and-extract', 10:03:20 INFO - 'populate-webroot', 10:03:20 INFO - 'create-virtualenv', 10:03:20 INFO - 'install', 10:03:20 INFO - 'run-tests'), 10:03:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:03:20 INFO - 'download_minidump_stackwalk': True, 10:03:20 INFO - 'download_symbols': 'ondemand', 10:03:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:03:20 INFO - 'tooltool.py': '/tools/tooltool.py', 10:03:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:03:20 INFO - '/tools/misc-python/virtualenv.py')}, 10:03:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:03:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:03:20 INFO - 'installer_path': 'installer.exe', 10:03:20 INFO - 'log_level': 'info', 10:03:20 INFO - 'log_name': 'talos', 10:03:20 INFO - 'log_to_console': True, 10:03:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:03:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:03:20 INFO - 'opt_config_files': (), 10:03:20 INFO - 'pip_index': False, 10:03:20 INFO - 'sps_profile': False, 10:03:20 INFO - 'sps_profile_interval': 0, 10:03:20 INFO - 'suite': 'dromaeojs', 10:03:20 INFO - 'system_bits': '32', 10:03:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:03:20 INFO - 'title': 'talos-linux64-ix-037', 10:03:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:03:20 INFO - 'use_talos_json': True, 10:03:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:03:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:03:20 INFO - 'work_dir': 'build'} 10:03:20 INFO - [mozharness: 2017-01-05 18:03:20.244505Z] Running clobber step. 10:03:20 INFO - Running pre-action listener: _resource_record_pre_action 10:03:20 INFO - Running main action method: clobber 10:03:20 INFO - rmtree: /builds/slave/test/build 10:03:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:03:20 INFO - Running post-action listener: _resource_record_post_action 10:03:20 INFO - [mozharness: 2017-01-05 18:03:20.656161Z] Finished clobber step (success) 10:03:20 INFO - [mozharness: 2017-01-05 18:03:20.656261Z] Running read-buildbot-config step. 10:03:20 INFO - Running pre-action listener: _resource_record_pre_action 10:03:20 INFO - Running main action method: read_buildbot_config 10:03:20 INFO - Using buildbot properties: 10:03:20 INFO - { 10:03:20 INFO - "project": "", 10:03:20 INFO - "product": "firefox", 10:03:20 INFO - "script_repo_revision": "production", 10:03:20 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:03:20 INFO - "repository": "", 10:03:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:03:20 INFO - "buildid": "20170105081520", 10:03:20 INFO - "pgo_build": "True", 10:03:20 INFO - "basedir": "/builds/slave/test", 10:03:20 INFO - "buildnumber": 506, 10:03:20 INFO - "slavename": "talos-linux64-ix-037", 10:03:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:03:20 INFO - "platform": "ubuntu64_hw", 10:03:20 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:03:20 INFO - "branch": "mozilla-beta", 10:03:20 INFO - "repo_path": "releases/mozilla-beta", 10:03:20 INFO - "revision": "faa5342a058268bdba1b87b65e56a55d51522bbf", 10:03:20 INFO - "stage_platform": "linux64-pgo", 10:03:20 INFO - "builduid": "2f14b02bc5ec408b882de18ca79cd87c", 10:03:20 INFO - "slavebuilddir": "test" 10:03:20 INFO - } 10:03:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 10:03:20 INFO - Running post-action listener: _resource_record_post_action 10:03:20 INFO - [mozharness: 2017-01-05 18:03:20.658697Z] Finished read-buildbot-config step (success) 10:03:20 INFO - [mozharness: 2017-01-05 18:03:20.658785Z] Running download-and-extract step. 10:03:20 INFO - Running pre-action listener: _resource_record_pre_action 10:03:20 INFO - Running main action method: download_and_extract 10:03:20 INFO - mkdir: /builds/slave/test/build/tests 10:03:20 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')]} 10:03:20 INFO - trying https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 10:03:20 INFO - Downloading https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/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 10:03:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/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 10:03:21 INFO - Downloaded 1327 bytes. 10:03:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 10:03:21 INFO - Using the following test package requirements: 10:03:21 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 10:03:21 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:03:21 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:03:21 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:03:21 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 10:03:21 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:03:21 INFO - u'jsshell-linux-x86_64.zip'], 10:03:21 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:03:21 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:03:21 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 10:03:21 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:03:21 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 10:03:21 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:03:21 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 10:03:21 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:03:21 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:03:21 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:03:21 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:03:21 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:03:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 10:03:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:03:21 INFO - Fetch https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 10:03:21 INFO - Expected file size: 21969708 10:03:26 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 10:03:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 10:03:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:03:26 INFO - Fetch https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 10:03:26 INFO - Expected file size: 21969708 10:03:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 10:03:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:03:31 INFO - Fetch https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 10:03:32 INFO - Expected file size: 14414089 10:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:32 INFO - trying https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:03:32 INFO - Downloading https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/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 10:03:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/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 10:03:33 INFO - Downloaded 56964641 bytes. 10:03:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:03:33 INFO - mkdir: /builds/slave/test/properties 10:03:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:03:33 INFO - Writing to file /builds/slave/test/properties/build_url 10:03:33 INFO - Contents: 10:03:33 INFO - build_url:https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:03:34 INFO - Running post-action listener: _resource_record_post_action 10:03:34 INFO - Running post-action listener: set_extra_try_arguments 10:03:34 INFO - [mozharness: 2017-01-05 18:03:34.236289Z] Finished download-and-extract step (success) 10:03:34 INFO - [mozharness: 2017-01-05 18:03:34.236516Z] Running populate-webroot step. 10:03:34 INFO - Running pre-action listener: _resource_record_pre_action 10:03:34 INFO - Running main action method: populate_webroot 10:03:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:03:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:03:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:03:34 INFO - '--tppagecycles', 10:03:34 INFO - '7'], 10:03:34 INFO - 'tests': ['tsvgm']}}, 10:03:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:03:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:03:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:03:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:03:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:34 INFO - 'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:34 INFO - 'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['damp', 'tps']}, 10:03:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:34 INFO - 'tests': ['damp', 'tps']}, 10:03:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['dromaeo_dom']}, 10:03:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:03:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['basic_compositor_video']}, 10:03:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:03:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['a11yr', 10:03:34 INFO - 'ts_paint', 10:03:34 INFO - 'tpaint', 10:03:34 INFO - 'sessionrestore', 10:03:34 INFO - 'sessionrestore_no_auto_restore', 10:03:34 INFO - 'tabpaint']}, 10:03:34 INFO - 'other-e10s': {'tests': ['a11yr', 10:03:34 INFO - 'ts_paint', 10:03:34 INFO - 'tpaint', 10:03:34 INFO - 'sessionrestore', 10:03:34 INFO - 'sessionrestore_no_auto_restore', 10:03:34 INFO - 'tabpaint']}, 10:03:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:03:34 INFO - 'ts_paint', 10:03:34 INFO - 'tpaint', 10:03:34 INFO - 'sessionrestore', 10:03:34 INFO - 'sessionrestore_no_auto_restore', 10:03:34 INFO - 'tabpaint']}, 10:03:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:03:34 INFO - 'ts_paint', 10:03:34 INFO - 'tpaint', 10:03:34 INFO - 'sessionrestore', 10:03:34 INFO - 'sessionrestore_no_auto_restore', 10:03:34 INFO - 'tabpaint']}, 10:03:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['a11yr', 10:03:34 INFO - 'ts_paint', 10:03:34 INFO - 'tpaint', 10:03:34 INFO - 'sessionrestore', 10:03:34 INFO - 'sessionrestore_no_auto_restore', 10:03:34 INFO - 'tabpaint']}, 10:03:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['a11yr', 10:03:34 INFO - 'ts_paint', 10:03:34 INFO - 'tpaint', 10:03:34 INFO - 'sessionrestore', 10:03:34 INFO - 'sessionrestore_no_auto_restore', 10:03:34 INFO - 'tabpaint']}, 10:03:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['tsvgx', 10:03:34 INFO - 'tsvgr_opacity', 10:03:34 INFO - 'tart', 10:03:34 INFO - 'tscrollx', 10:03:34 INFO - 'cart']}, 10:03:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:03:34 INFO - 'tsvgr_opacity', 10:03:34 INFO - 'tart', 10:03:34 INFO - 'tscrollx', 10:03:34 INFO - 'cart']}, 10:03:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:34 INFO - 'talos_options': ['--disable-e10s'], 10:03:34 INFO - 'tests': ['tp5o']}, 10:03:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:34 INFO - 'tests': ['tp5o']}, 10:03:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:34 INFO - 'talos_options': ['--disable-e10s', 10:03:34 INFO - '--xperf_path', 10:03:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:34 INFO - 'tests': ['tp5n']}, 10:03:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:34 INFO - 'talos_options': ['--xperf_path', 10:03:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:34 INFO - 'tests': ['tp5n']}}, 10:03:34 INFO - 'talos.zip': {'path': '', 10:03:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:03:34 INFO - Running post-action listener: _resource_record_post_action 10:03:34 INFO - [mozharness: 2017-01-05 18:03:34.257993Z] Finished populate-webroot step (success) 10:03:34 INFO - [mozharness: 2017-01-05 18:03:34.258087Z] Running create-virtualenv step. 10:03:34 INFO - Running pre-action listener: _resource_record_pre_action 10:03:34 INFO - Running main action method: create_virtualenv 10:03:34 INFO - Creating virtualenv /builds/slave/test/build/venv 10:03:34 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 10:03:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:03:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:03:34 INFO - Using real prefix '/usr' 10:03:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:03:35 INFO - Installing distribute.............................................................................................................................................................................................done. 10:03:36 INFO - Installing pip.................done. 10:03:36 INFO - Return code: 0 10:03:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:36 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 0x7fdfa48cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', '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 10:03:36 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 10:03:36 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 10:03:36 INFO - Using env: {'DISPLAY': ':0', 10:03:36 INFO - 'HOME': '/home/cltbld', 10:03:36 INFO - 'LANG': 'en_US.UTF-8', 10:03:36 INFO - 'LANGUAGE': 'en_US:en', 10:03:36 INFO - 'LOGNAME': 'cltbld', 10:03:36 INFO - 'MAIL': '/var/mail/cltbld', 10:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:36 INFO - 'MOZ_NO_REMOTE': '1', 10:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:36 INFO - 'NO_EM_RESTART': '1', 10:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:36 INFO - 'PWD': '/builds/slave/test', 10:03:36 INFO - 'SHELL': '/bin/bash', 10:03:36 INFO - 'SHLVL': '1', 10:03:36 INFO - 'TERM': 'linux', 10:03:36 INFO - 'TMOUT': '86400', 10:03:36 INFO - 'USER': 'cltbld', 10:03:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:36 INFO - '_': '/tools/buildbot/bin/python'} 10:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:37 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 10:03:37 INFO - Cleaning up... 10:03:37 INFO - Return code: 0 10:03:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:03:37 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')]} 10:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:37 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')]} 10:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:37 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 0x7fdfa48cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', '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 10:03:37 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 10:03:37 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 10:03:37 INFO - Using env: {'DISPLAY': ':0', 10:03:37 INFO - 'HOME': '/home/cltbld', 10:03:37 INFO - 'LANG': 'en_US.UTF-8', 10:03:37 INFO - 'LANGUAGE': 'en_US:en', 10:03:37 INFO - 'LOGNAME': 'cltbld', 10:03:37 INFO - 'MAIL': '/var/mail/cltbld', 10:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:37 INFO - 'MOZ_NO_REMOTE': '1', 10:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:37 INFO - 'NO_EM_RESTART': '1', 10:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:37 INFO - 'PWD': '/builds/slave/test', 10:03:37 INFO - 'SHELL': '/bin/bash', 10:03:37 INFO - 'SHLVL': '1', 10:03:37 INFO - 'TERM': 'linux', 10:03:37 INFO - 'TMOUT': '86400', 10:03:37 INFO - 'USER': 'cltbld', 10:03:37 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:37 INFO - '_': '/tools/buildbot/bin/python'} 10:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:37 INFO - Downloading/unpacking psutil>=3.1.1 10:03:37 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 10:03:37 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 10:03:37 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 10:03:37 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 10:03:37 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 10:03:37 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 10:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:03:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:39 INFO - Installing collected packages: psutil 10:03:39 INFO - Running setup.py install for psutil 10:03:39 INFO - building 'psutil._psutil_linux' extension 10:03:39 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 10:03:40 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 10:03:40 INFO - building 'psutil._psutil_posix' extension 10:03:40 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 10:03:41 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 10:03:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:41 INFO - Successfully installed psutil 10:03:41 INFO - Cleaning up... 10:03:41 INFO - Return code: 0 10:03:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:03:41 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')]} 10:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:41 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')]} 10:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:41 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 0x7fdfa48cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', '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 10:03:41 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 10:03:41 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 10:03:41 INFO - Using env: {'DISPLAY': ':0', 10:03:41 INFO - 'HOME': '/home/cltbld', 10:03:41 INFO - 'LANG': 'en_US.UTF-8', 10:03:41 INFO - 'LANGUAGE': 'en_US:en', 10:03:41 INFO - 'LOGNAME': 'cltbld', 10:03:41 INFO - 'MAIL': '/var/mail/cltbld', 10:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:41 INFO - 'MOZ_NO_REMOTE': '1', 10:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:41 INFO - 'NO_EM_RESTART': '1', 10:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:41 INFO - 'PWD': '/builds/slave/test', 10:03:41 INFO - 'SHELL': '/bin/bash', 10:03:41 INFO - 'SHLVL': '1', 10:03:41 INFO - 'TERM': 'linux', 10:03:41 INFO - 'TMOUT': '86400', 10:03:41 INFO - 'USER': 'cltbld', 10:03:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:41 INFO - '_': '/tools/buildbot/bin/python'} 10:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:03:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:03:43 INFO - Installing collected packages: mozsystemmonitor 10:03:43 INFO - Running setup.py install for mozsystemmonitor 10:03:43 INFO - Successfully installed mozsystemmonitor 10:03:43 INFO - Cleaning up... 10:03:43 INFO - Return code: 0 10:03:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa48cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', '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 10:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:03:43 INFO - Using env: {'DISPLAY': ':0', 10:03:43 INFO - 'HOME': '/home/cltbld', 10:03:43 INFO - 'LANG': 'en_US.UTF-8', 10:03:43 INFO - 'LANGUAGE': 'en_US:en', 10:03:43 INFO - 'LOGNAME': 'cltbld', 10:03:43 INFO - 'MAIL': '/var/mail/cltbld', 10:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:43 INFO - 'MOZ_NO_REMOTE': '1', 10:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:43 INFO - 'NO_EM_RESTART': '1', 10:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:43 INFO - 'PWD': '/builds/slave/test', 10:03:43 INFO - 'SHELL': '/bin/bash', 10:03:43 INFO - 'SHLVL': '1', 10:03:43 INFO - 'TERM': 'linux', 10:03:43 INFO - 'TMOUT': '86400', 10:03:43 INFO - 'USER': 'cltbld', 10:03:43 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:43 INFO - '_': '/tools/buildbot/bin/python'} 10:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:43 INFO - Downloading/unpacking jsonschema==2.5.1 10:03:43 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 10:03:43 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 10:03:43 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 10:03:43 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 10:03:43 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 10:03:43 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 10:03:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:03:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:03:46 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 10:03:46 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 10:03:46 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 10:03:46 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 10:03:46 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 10:03:46 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 10:03:46 INFO - Downloading functools32-3.2.3-2.tar.gz 10:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:03:46 INFO - warning: no files found matching '*.txt' 10:03:46 INFO - no previously-included directories found matching 'build' 10:03:46 INFO - no previously-included directories found matching 'dist' 10:03:46 INFO - no previously-included directories found matching '.git*' 10:03:46 INFO - Installing collected packages: jsonschema, functools32 10:03:46 INFO - Running setup.py install for functools32 10:03:46 INFO - warning: no files found matching '*.txt' 10:03:46 INFO - no previously-included directories found matching 'build' 10:03:46 INFO - no previously-included directories found matching 'dist' 10:03:46 INFO - no previously-included directories found matching '.git*' 10:03:46 INFO - Successfully installed jsonschema functools32 10:03:46 INFO - Cleaning up... 10:03:46 INFO - Return code: 0 10:03:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:46 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 0x7fdfa48cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', '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 10:03:46 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 10:03:46 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 10:03:46 INFO - Using env: {'DISPLAY': ':0', 10:03:46 INFO - 'HOME': '/home/cltbld', 10:03:46 INFO - 'LANG': 'en_US.UTF-8', 10:03:46 INFO - 'LANGUAGE': 'en_US:en', 10:03:46 INFO - 'LOGNAME': 'cltbld', 10:03:46 INFO - 'MAIL': '/var/mail/cltbld', 10:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:46 INFO - 'MOZ_NO_REMOTE': '1', 10:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:46 INFO - 'NO_EM_RESTART': '1', 10:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:46 INFO - 'PWD': '/builds/slave/test', 10:03:46 INFO - 'SHELL': '/bin/bash', 10:03:46 INFO - 'SHLVL': '1', 10:03:46 INFO - 'TERM': 'linux', 10:03:46 INFO - 'TMOUT': '86400', 10:03:46 INFO - 'USER': 'cltbld', 10:03:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:46 INFO - '_': '/tools/buildbot/bin/python'} 10:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:03:46 INFO - Cleaning up... 10:03:46 INFO - Return code: 0 10:03:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:46 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 0x7fdfa48cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', '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 10:03:46 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 10:03:46 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 10:03:46 INFO - Using env: {'DISPLAY': ':0', 10:03:46 INFO - 'HOME': '/home/cltbld', 10:03:46 INFO - 'LANG': 'en_US.UTF-8', 10:03:46 INFO - 'LANGUAGE': 'en_US:en', 10:03:46 INFO - 'LOGNAME': 'cltbld', 10:03:46 INFO - 'MAIL': '/var/mail/cltbld', 10:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:46 INFO - 'MOZ_NO_REMOTE': '1', 10:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:46 INFO - 'NO_EM_RESTART': '1', 10:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:46 INFO - 'PWD': '/builds/slave/test', 10:03:46 INFO - 'SHELL': '/bin/bash', 10:03:46 INFO - 'SHLVL': '1', 10:03:46 INFO - 'TERM': 'linux', 10:03:46 INFO - 'TMOUT': '86400', 10:03:46 INFO - 'USER': 'cltbld', 10:03:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:46 INFO - '_': '/tools/buildbot/bin/python'} 10:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:49 INFO - Downloading blobuploader-1.2.4.tar.gz 10:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:03:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:03:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:49 INFO - Downloading docopt-0.6.1.tar.gz 10:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:03:49 INFO - Installing collected packages: blobuploader, requests, docopt 10:03:49 INFO - Running setup.py install for blobuploader 10:03:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:03:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:03:50 INFO - Running setup.py install for requests 10:03:50 INFO - Running setup.py install for docopt 10:03:50 INFO - Successfully installed blobuploader requests docopt 10:03:50 INFO - Cleaning up... 10:03:50 INFO - Return code: 0 10:03:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:50 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 0x7fdfa48cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', '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 10:03:50 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 10:03:50 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 10:03:50 INFO - Using env: {'DISPLAY': ':0', 10:03:50 INFO - 'HOME': '/home/cltbld', 10:03:50 INFO - 'LANG': 'en_US.UTF-8', 10:03:50 INFO - 'LANGUAGE': 'en_US:en', 10:03:50 INFO - 'LOGNAME': 'cltbld', 10:03:50 INFO - 'MAIL': '/var/mail/cltbld', 10:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:50 INFO - 'MOZ_NO_REMOTE': '1', 10:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:50 INFO - 'NO_EM_RESTART': '1', 10:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:50 INFO - 'PWD': '/builds/slave/test', 10:03:50 INFO - 'SHELL': '/bin/bash', 10:03:50 INFO - 'SHLVL': '1', 10:03:50 INFO - 'TERM': 'linux', 10:03:50 INFO - 'TMOUT': '86400', 10:03:50 INFO - 'USER': 'cltbld', 10:03:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:50 INFO - '_': '/tools/buildbot/bin/python'} 10:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:50 INFO - Running setup.py (path:/tmp/pip-nqfGee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:50 INFO - Running setup.py (path:/tmp/pip-1E6OJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:50 INFO - Running setup.py (path:/tmp/pip-ymGXXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:51 INFO - Running setup.py (path:/tmp/pip-mIB55i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:51 INFO - Running setup.py (path:/tmp/pip-zupUXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:51 INFO - Running setup.py (path:/tmp/pip-UYfTAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:51 INFO - Running setup.py (path:/tmp/pip-tAB92u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:51 INFO - Running setup.py (path:/tmp/pip-IpWiux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:51 INFO - Running setup.py (path:/tmp/pip-p07uj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:51 INFO - Running setup.py (path:/tmp/pip-fIQuMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:51 INFO - Running setup.py (path:/tmp/pip-PP_XK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:51 INFO - Running setup.py (path:/tmp/pip-41XZp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:51 INFO - Running setup.py (path:/tmp/pip-p6i2Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:51 INFO - Running setup.py (path:/tmp/pip-sfNuBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:51 INFO - Running setup.py (path:/tmp/pip-9q8uIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:51 INFO - Running setup.py (path:/tmp/pip-qw5gBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:51 INFO - Running setup.py (path:/tmp/pip-qfTUuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:03:51 INFO - Running setup.py install for manifestparser 10:03:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:03:52 INFO - Running setup.py install for mozcrash 10:03:52 INFO - Running setup.py install for mozdebug 10:03:52 INFO - Running setup.py install for mozdevice 10:03:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:03:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:03:52 INFO - Running setup.py install for mozfile 10:03:52 INFO - Running setup.py install for mozhttpd 10:03:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:03:52 INFO - Running setup.py install for mozinfo 10:03:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:03:52 INFO - Running setup.py install for mozInstall 10:03:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:03:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:03:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:03:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:03:52 INFO - Running setup.py install for mozleak 10:03:52 INFO - Running setup.py install for mozlog 10:03:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:03:53 INFO - Running setup.py install for moznetwork 10:03:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:03:53 INFO - Running setup.py install for mozprocess 10:03:53 INFO - Running setup.py install for mozprofile 10:03:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:03:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:03:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:03:53 INFO - Running setup.py install for mozrunner 10:03:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:03:53 INFO - Running setup.py install for mozscreenshot 10:03:53 INFO - Running setup.py install for moztest 10:03:53 INFO - Running setup.py install for mozversion 10:03:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:03:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:03:54 INFO - Cleaning up... 10:03:54 INFO - Return code: 0 10:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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')]} 10:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:54 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 0x7fdfa48cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', '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 10:03:54 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 10:03:54 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 10:03:54 INFO - Using env: {'DISPLAY': ':0', 10:03:54 INFO - 'HOME': '/home/cltbld', 10:03:54 INFO - 'LANG': 'en_US.UTF-8', 10:03:54 INFO - 'LANGUAGE': 'en_US:en', 10:03:54 INFO - 'LOGNAME': 'cltbld', 10:03:54 INFO - 'MAIL': '/var/mail/cltbld', 10:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:54 INFO - 'MOZ_NO_REMOTE': '1', 10:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:54 INFO - 'NO_EM_RESTART': '1', 10:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:54 INFO - 'PWD': '/builds/slave/test', 10:03:54 INFO - 'SHELL': '/bin/bash', 10:03:54 INFO - 'SHLVL': '1', 10:03:54 INFO - 'TERM': 'linux', 10:03:54 INFO - 'TMOUT': '86400', 10:03:54 INFO - 'USER': 'cltbld', 10:03:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:54 INFO - '_': '/tools/buildbot/bin/python'} 10:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:54 INFO - Running setup.py (path:/tmp/pip-CtcxAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:54 INFO - Running setup.py (path:/tmp/pip-Uc8IKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:54 INFO - Running setup.py (path:/tmp/pip-iHHpQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:54 INFO - Running setup.py (path:/tmp/pip-daxAif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:54 INFO - Running setup.py (path:/tmp/pip-P3vNB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:54 INFO - Running setup.py (path:/tmp/pip-ou7HnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:54 INFO - Running setup.py (path:/tmp/pip-E1tXMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:54 INFO - Running setup.py (path:/tmp/pip-_xegoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:54 INFO - Running setup.py (path:/tmp/pip-93hKM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:54 INFO - Running setup.py (path:/tmp/pip-CXAKA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:54 INFO - Running setup.py (path:/tmp/pip-CpsdZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:54 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)) 10:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:55 INFO - Running setup.py (path:/tmp/pip-e7C0BY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:55 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)) 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:55 INFO - Running setup.py (path:/tmp/pip-L8E7Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:55 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)) 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:55 INFO - Running setup.py (path:/tmp/pip-qraX9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:55 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)) 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:55 INFO - Running setup.py (path:/tmp/pip-qAg3A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:55 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)) 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:55 INFO - Running setup.py (path:/tmp/pip-4lz3Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:55 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)) 10:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:55 INFO - Running setup.py (path:/tmp/pip-kpwdkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:55 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)) 10:03:55 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)) 10:03:55 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)) 10:03:55 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)) 10:03:55 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)) 10:03:55 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)) 10:03:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:57 INFO - Downloading blessings-1.6.tar.gz 10:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:03:57 INFO - Installing collected packages: blessings 10:03:57 INFO - Running setup.py install for blessings 10:03:57 INFO - Successfully installed blessings 10:03:57 INFO - Cleaning up... 10:03:57 INFO - Return code: 0 10:03:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:03:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:57 INFO - Reading from file tmpfile_stdout 10:03:57 INFO - Current package versions: 10:03:57 INFO - argparse == 1.2.1 10:03:57 INFO - blessings == 1.6 10:03:57 INFO - blobuploader == 1.2.4 10:03:57 INFO - docopt == 0.6.1 10:03:57 INFO - functools32 == 3.2.3-2 10:03:57 INFO - jsonschema == 2.5.1 10:03:57 INFO - manifestparser == 1.1 10:03:57 INFO - mozInstall == 1.12 10:03:57 INFO - mozcrash == 0.17 10:03:57 INFO - mozdebug == 0.1 10:03:57 INFO - mozdevice == 0.48 10:03:57 INFO - mozfile == 1.2 10:03:57 INFO - mozhttpd == 0.7 10:03:57 INFO - mozinfo == 0.9 10:03:57 INFO - mozleak == 0.1 10:03:57 INFO - mozlog == 3.4 10:03:57 INFO - moznetwork == 0.27 10:03:57 INFO - mozprocess == 0.23 10:03:57 INFO - mozprofile == 0.28 10:03:57 INFO - mozrunner == 6.12 10:03:57 INFO - mozscreenshot == 0.1 10:03:57 INFO - mozsystemmonitor == 0.3 10:03:57 INFO - moztest == 0.7 10:03:57 INFO - mozversion == 1.4 10:03:57 INFO - psutil == 3.1.1 10:03:57 INFO - requests == 1.2.3 10:03:57 INFO - wsgiref == 0.1.2 10:03:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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')]} 10:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:57 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 0x7fdfa48cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', '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 10:03:57 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 10:03:57 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 10:03:57 INFO - Using env: {'DISPLAY': ':0', 10:03:57 INFO - 'HOME': '/home/cltbld', 10:03:57 INFO - 'LANG': 'en_US.UTF-8', 10:03:57 INFO - 'LANGUAGE': 'en_US:en', 10:03:57 INFO - 'LOGNAME': 'cltbld', 10:03:57 INFO - 'MAIL': '/var/mail/cltbld', 10:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:57 INFO - 'MOZ_NO_REMOTE': '1', 10:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:57 INFO - 'NO_EM_RESTART': '1', 10:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:57 INFO - 'PWD': '/builds/slave/test', 10:03:57 INFO - 'SHELL': '/bin/bash', 10:03:57 INFO - 'SHLVL': '1', 10:03:57 INFO - 'TERM': 'linux', 10:03:57 INFO - 'TMOUT': '86400', 10:03:57 INFO - 'USER': 'cltbld', 10:03:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:57 INFO - '_': '/tools/buildbot/bin/python'} 10:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:58 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)) 10:03:58 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)) 10:03:58 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)) 10:03:58 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)) 10:03:58 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)) 10:03:58 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)) 10:03:58 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)) 10:03:58 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)) 10:03:58 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)) 10:03:58 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)) 10:03:58 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)) 10:03:58 INFO - Cleaning up... 10:03:58 INFO - Return code: 0 10:03:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa48cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', '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 10:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:03:58 INFO - Using env: {'DISPLAY': ':0', 10:03:58 INFO - 'HOME': '/home/cltbld', 10:03:58 INFO - 'LANG': 'en_US.UTF-8', 10:03:58 INFO - 'LANGUAGE': 'en_US:en', 10:03:58 INFO - 'LOGNAME': 'cltbld', 10:03:58 INFO - 'MAIL': '/var/mail/cltbld', 10:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:58 INFO - 'MOZ_NO_REMOTE': '1', 10:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:58 INFO - 'NO_EM_RESTART': '1', 10:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:58 INFO - 'PWD': '/builds/slave/test', 10:03:58 INFO - 'SHELL': '/bin/bash', 10:03:58 INFO - 'SHLVL': '1', 10:03:58 INFO - 'TERM': 'linux', 10:03:58 INFO - 'TMOUT': '86400', 10:03:58 INFO - 'USER': 'cltbld', 10:03:58 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:58 INFO - '_': '/tools/buildbot/bin/python'} 10:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:03:58 INFO - Cleaning up... 10:03:58 INFO - Return code: 0 10:03:58 INFO - Running post-action listener: _resource_record_post_action 10:03:58 INFO - Running post-action listener: _start_resource_monitoring 10:03:58 INFO - Starting resource monitoring. 10:03:58 INFO - [mozharness: 2017-01-05 18:03:58.385455Z] Finished create-virtualenv step (success) 10:03:58 INFO - [mozharness: 2017-01-05 18:03:58.386464Z] Running install step. 10:03:58 INFO - Running pre-action listener: _resource_record_pre_action 10:03:58 INFO - Running main action method: install 10:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:58 INFO - Reading from file tmpfile_stdout 10:03:58 INFO - Detecting whether we're running mozinstall >=1.0... 10:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:03:58 INFO - Reading from file tmpfile_stdout 10:03:58 INFO - Output received: 10:03:58 INFO - Usage: mozinstall [options] installer 10:03:58 INFO - Options: 10:03:58 INFO - -h, --help show this help message and exit 10:03:58 INFO - -d DEST, --destination=DEST 10:03:58 INFO - Directory to install application into. [default: 10:03:58 INFO - "/builds/slave/test"] 10:03:58 INFO - --app=APP Application being installed. [default: firefox] 10:03:58 INFO - mkdir: /builds/slave/test/build/application 10:03:58 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'] 10:03:58 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 10:04:12 INFO - Reading from file tmpfile_stdout 10:04:12 INFO - Output received: 10:04:12 INFO - /builds/slave/test/build/application/firefox/firefox 10:04:12 INFO - Running post-action listener: _resource_record_post_action 10:04:12 INFO - [mozharness: 2017-01-05 18:04:12.161854Z] Finished install step (success) 10:04:12 INFO - [mozharness: 2017-01-05 18:04:12.162098Z] Running run-tests step. 10:04:12 INFO - Running pre-action listener: _resource_record_pre_action 10:04:12 INFO - Running main action method: run_tests 10:04:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:04:12 INFO - Python 2.7.3 10:04:12 INFO - Return code: 0 10:04:12 INFO - grabbing minidump binary from tooltool 10:04:12 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')]} 10:04:12 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 0x27e4f60>, '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 0x27e5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:04:12 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 10:04:12 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 10:04:12 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 10:04:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:04:12 INFO - Return code: 0 10:04:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:04:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:04:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:04:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:04:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:04:12 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/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 10:04:12 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/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 10:04:12 INFO - Using env: {'DISPLAY': ':0', 10:04:12 INFO - 'HOME': '/home/cltbld', 10:04:12 INFO - 'LANG': 'en_US.UTF-8', 10:04:12 INFO - 'LANGUAGE': 'en_US:en', 10:04:12 INFO - 'LOGNAME': 'cltbld', 10:04:12 INFO - 'MAIL': '/var/mail/cltbld', 10:04:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:04:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:12 INFO - 'MOZ_NO_REMOTE': '1', 10:04:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:12 INFO - 'NO_EM_RESTART': '1', 10:04:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:12 INFO - 'PWD': '/builds/slave/test', 10:04:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:04:12 INFO - 'SHELL': '/bin/bash', 10:04:12 INFO - 'SHLVL': '1', 10:04:12 INFO - 'TERM': 'linux', 10:04:12 INFO - 'TMOUT': '86400', 10:04:12 INFO - 'USER': 'cltbld', 10:04:12 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982', 10:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:12 INFO - '_': '/tools/buildbot/bin/python'} 10:04:12 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/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 10:04:12 INFO - mozversion application_buildid: 20170105081520 10:04:12 INFO - mozversion application_changeset: faa5342a058268bdba1b87b65e56a55d51522bbf 10:04:12 INFO - mozversion application_display_name: Firefox 10:04:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:04:12 INFO - mozversion application_name: Firefox 10:04:12 INFO - mozversion application_remotingname: firefox 10:04:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:04:12 INFO - mozversion application_vendor: Mozilla 10:04:12 INFO - mozversion application_version: 51.0 10:04:12 INFO - mozversion platform_buildid: 20170105081520 10:04:12 INFO - mozversion platform_changeset: faa5342a058268bdba1b87b65e56a55d51522bbf 10:04:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:04:12 INFO - mozversion platform_version: 51.0 10:04:12 INFO - using testdate: 1483639452 10:04:12 INFO - actual date: 1483639452 10:04:12 INFO - starting webserver on 'localhost:42359' 10:04:12 INFO - SUITE-START | Running 2 tests 10:04:12 INFO - TEST-START | dromaeo_css 10:04:12 INFO - operating with platform_type : linux_ 10:04:12 INFO - Initialising browser for dromaeo_css test... 10:04:12 INFO - TEST-INFO | started process 3288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpczW9Do/profile http://localhost:42359/getInfo.html) 10:04:18 INFO - PROCESS | 3288 | __metrics Screen width/height:1600/1200 10:04:18 INFO - PROCESS | 3288 | colorDepth:24 10:04:18 INFO - PROCESS | 3288 | Browser inner width/height: 1024/697 10:04:18 INFO - PROCESS | 3288 | __metrics 10:04:18 INFO - PROCESS | 3288 | 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" 10:04:19 INFO - PROCESS | 3288 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:04:19 INFO - PROCESS | 3288 | console.error: PushService: 10:04:19 INFO - PROCESS | 3288 | stateChangeProcessEnqueue: Error transitioning state 10:04:19 INFO - PROCESS | 3288 | UnknownError 10:04:20 INFO - TEST-INFO | 3288: exit 0 10:04:20 INFO - Browser initialized. 10:04:20 INFO - Running cycle 1/1 for dromaeo_css test... 10:04:20 INFO - TEST-INFO | started process 3384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpczW9Do/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:32 INFO - PROCESS | 3384 | RSS: Main: 142692352 10:04:32 INFO - PROCESS | 3384 | 10:05:23 INFO - PROCESS | 3384 | 1483639523607 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] 10:07:32 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42359/tests/dromaeo/cssquery-ext.html) 10:07:33 INFO - PROCESS | 3384 | RSS: Main: 242925568 10:07:33 INFO - PROCESS | 3384 | 10:10:36 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-ext.html (next: http://localhost:42359/tests/dromaeo/cssquery-jquery.html) 10:10:36 INFO - PROCESS | 3384 | RSS: Main: 226455552 10:10:36 INFO - PROCESS | 3384 | 10:13:38 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42359/tests/dromaeo/cssquery-mootools.html) 10:13:39 INFO - PROCESS | 3384 | RSS: Main: 212135936 10:13:39 INFO - PROCESS | 3384 | 10:16:40 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42359/tests/dromaeo/cssquery-prototype.html) 10:16:41 INFO - PROCESS | 3384 | RSS: Main: 202555392 10:16:41 INFO - PROCESS | 3384 | 10:19:44 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42359/tests/dromaeo/cssquery-yui.html) 10:19:44 INFO - PROCESS | 3384 | RSS: Main: 175861760 10:19:44 INFO - PROCESS | 3384 | 10:22:47 INFO - PROCESS | 3384 | Cycle 1(1): loaded http://localhost:42359/tests/dromaeo/cssquery-yui.html (next: http://localhost:42359/tests/dromaeo/cssquery-dojo.html) 10:22:47 INFO - PROCESS | 3384 | RSS: Main: 264851456 10:22:47 INFO - PROCESS | 3384 | 10:22:47 INFO - PROCESS | 3384 | __start_tp_report 10:22:47 INFO - PROCESS | 3384 | _x_x_mozilla_page_load 10:22:47 INFO - PROCESS | 3384 | _x_x_mozilla_page_load_details 10:22:47 INFO - PROCESS | 3384 | |i|pagename|runs| 10:22:47 INFO - PROCESS | 3384 | |0;dojo.html;3109.331493728848;3161.0200837740294;3177.110409085457;3190.011096560068;3209.422303985283;5530.6128571;5611.3266408030995;5614.129809879475;5631.380548139707;5639.520640745536;5600.691961942091;5642.802501912434;5647.29408823897;5648.209250704905;5661.3206415230125;5110.335656364668;5112.054269960051;5146.768395422197;5162.561182299509;5181.1710126379785;5037.496250374951;5067.315912351841;5148.613853960949;5199.722973747282;5223.63434559579;5049.4698056704065;5063.215201643733;5068.417132029808;5127.461616530267;5128.615353848458;5159.690418574897;5169.922451163236;5183.792648294064;5252.842414727526;5253.579713622901;5051;5142.974285128588;5206.167013277895;5215.217717342391;5237.895242095175;5420.4850539198715;5468.644538105011;5539.473749993744;5581.6930068846195;5609.831705048855;5993.490553302974;6008.789692360747;6113.449789518964;6114.480269177081;6116.327204007555;6141.723622437001;6151.569390142692;6157.692115394212;6158.04550294705;6168.198134242564;5474.972625136849;5517.144842549411;5538.280023596987;5543.556515478833;5551.666899986014;6178.474829639441;6189.690515474208;6189.907151392733;6190.071489276645;6192.287886893065;5908.350081491032;5908.852278693067;5919.852003699856;5923;5928.881422371528;5713.428657134336;5721.799737009268;5823.56323275756;5832.416758324219;5834.38738932406;5887.0580707086665;5888.911666325009;5892.94107058924;5915.053591425351;5932.169496270526;5859.648421094748;5881.529477641779;5925.111233315038;5927.081302398135;5927.229460170151;4496.64026877849;4525.683202175816;4568.269076947672;4615.630749540029;4634.37435946143;4121.464209652726;4139.234241665302;4153.792310384469;4162.313218319004;4184.8744537663915;5785.10330898703;5793.333766616893;5796.304443466811;5797.88404231913;5807.651540907559;5878.118282257696;5926.407359264125;5975.492083172892;6048.758049677964;6062.818115456544;5768.423157684198;5837.47462728348;5849.502792262705;5873.559483038789;5874.794382196688;5240;5275.103232450492;5293.655912365684;5294.23233631129;5298.364196296392;6080.209572755602;6123.908141377794;6164.4143806338325;6202.596831206048;6217.533684973555;5956.821295361146;5983.1025346196675;6019.458248757633;6076.969615151896;6116.357782432959;6184.505239580732;6214.440700336811;6217.253929528486;6218.875622487434;6289.433950944437;5704.087346024616;5960.8807823844145;5962.016267315845;5969.313528944053;6002.609830361012;5795.1017592273265;5987.700614969147;6031.366706495754;6065.272167339947;6146.815595532141;5927.288725352985;5967.8209653710455;5975.312839023568;5984.431479009487;6003.309619393825;5946.256717910262;5986.9401305986385;5990.161377407254;5994.70026498682;5998.25021872266;5677.148427735872;5774.653520788766;5780.190773291826;5813.069908814569;5828.533717302521;5921.851953701192;5923.200367950271;5924.851878702894;5930.021546444961;5952.5833191676165;5580.441955804387;5762.855928601818;5782.653040817564;5784.710764461676;5786.826395208151 10:22:47 INFO - PROCESS | 3384 | |1;ext.html;597.4652685846168;615.7352338494447;619.2940048344885;646.1987135951418;658.3844105761113;34709.30581388371;37743;47256.999999999956;48354;48530.27204591925;49380.259296110584;49848.750756246256;49859;50039.49960500394;50089.994600324004;9316.208122309596;9455.95272023639;9456.054394560557;9478.052194780501;9484.905150948505;8573.74278771638;8787.384883058157;11056.834147487794;11293.661190164308;11306.152038597096;11342.546298148065;11430.08559315257;11443.256188347772;11450.08399328056;11451.312921224711;11338.659840204766;11360.886391136148;11384.316940983485;11422.657320280363;11426.600068997586;11281.153913456441;11347;11347.148963827745;11349.09207263417;11357.375344356056;45900.311495327594;46209;46300.53699462996;46328.768356158005;46382.53617463816;3759.548854137521;3812.7712337259854;3948.072203032285;4186.099988502456;4446.57757513039;34201.973940781565;34404;34680.65319346825;34742.65257347445;35578.8221058893;3651.8174091295327;3721.497597824286;3756.7370284080125;3769.340365436065;3805.486259354979;372393;375205;378482;379872;380623;65095.67452162803;65491;65528;65560;65660.34339656637;41117.588824111976;41613.1677366451;41713.1657366851;44488.3326750099;67826.66086669634;18194.363197288032;18246.270149194148;18272.360467383576;18359.449216523524;18359.54101147482;12631;12877.806832897513;13942.093763905314;14046.297685115907;14046.367913443919;20511.58976820455;21102.155913763276;21194.894025529775;21730.456738581346;21751.782482174975;7371.336579707852;7567.281108294703;7588.27911348421;7600.885986710204;7716.7684969451;980.5587485631495;1032.0453580438216;1039.542601255445;1108.4845546820607;1157.5369852059243;35106.64893351085;35225;35270.8236458816;35445.64554354475;35580;1142.9942850285695;1158.9652310430702;1167.9007284380923;1176.7469993951343;1212.1757205100616;18436.907815460836;18437.26250949947;18550.536236594195;18592.628147436975;18673.439796805847;562168;570289;570397;570780;571002;64486.6775666128;65135.67432162809;65490.67254663696;65656.67171664111;65840.34159658341;1318.3935389720643;1367.746966811143;1405.641561401836;1409.2883094037445;1441.3946142620125;33918.491222632176;35672.821635892695;36002.8199858999;36044;36309.27381452409;55744;55890.72054639701;56115;56327.43672563222;56361.43638563562;411750;411944;412162;413480;414320;28008;28023.579646304916;28757.56863647089;32309.35381292408;32845.343093137526;47465;51553.48446515487;52704.7364763189;52854.20718689146;54455.18317225166;42952.57047429486;43619;44680.77659611681;45592.54407455883;45994.770026150996;43740.56259437365;44295.77852110719;44663.55336446594;45587;45976.77011614921;43046.784766077224;43047;43596.56403435925;43602.56397435985;43628.12743745171;37377.81311093427;39633.2073358537;40064.197111129484;40437.1912561753;40861.795691021354;29418.852905735333;29625.963091291702;30053.248668783457;30219.395612088076;30314.545281821232 10:22:47 INFO - PROCESS | 3384 | |2;jquery.html;426.8442018663185;435.4382846128494;440.33289566307053;444.52657919315925;446.44194756554316;18797.34209302673;20295.289664861695;20365.89817050913;20534.79465205351;20703.585928281424;19433.222671093175;19865.702014469796;19988.400347989547;20067.899660501676;20213;5631.971840140794;5941.405859414067;5942.465178133967;5947.464728174464;5948.43489868464;5750.597458177929;5783.392743761908;5788.942110578903;5790.7683692652245;5848.4736373726355;5744.0235160022685;5757;5762.7406766695385;5764.855878603047;5771.451712087366;5619.859503512424;5864.1203819427;5871.530277577784;5893.764249430018;5963.493103086243;5697.658140511582;5797.942020579824;5801.0428279333855;5803.448672376117;5828.941710582924;14040.929795350958;14471.565853024425;14865.628359290997;14869.925650371679;14886.032407893452;2405.675233843426;2417.589009868309;2477.863717495537;2704.2968828104836;3045.8477076146105;10520.267029101382;10628.627998020032;12110.939445302716;13203.2738199399;15741.527754167393;1913.292081929681;1964.2732189089986;2036.775954644988;2075.6263872502946;2088.9477763056043;59511;81754;87463.56268218682;87607;88281.55859220662;11768.470418831002;11802.232854864405;11894.464749086312;11936.28382297065;12066.09504287182;17036.57408564771;17124.486265411808;17125.48623541296;17132.571685707706;17144.914275428542;8216.055153657286;8371.623276952552;8423.536705481258;8435.662573496991;8464.619092140869;7759.883601745978;7775.883361749578;7834.218852307463;7906.683732650745;7928.6035698214855;4974.776135073858;5109.616778741535;5121.231815227746;5143.4085080216255;5182.24857395683;1831.541895775139;2037.7758446570865;2077.480629842539;2148.5058436559366;2185.8579192352445;989.9356541824758;1000.6047611193537;1025.7223414218413;1060.125396547851;1089.2647462962468;19469.805301947083;19717.211311547377;19794.60410791776;19880.403587892386;20264.797352026584;1008.3899240959261;1010.242318261304;1038.984415233772;1060.4591658254346;1065.6909496246158;10561.735956601147;10972.670819875257;10986.121110311156;11039.227254092137;11093.778124437627;539095;544078;554721;563914;566486;72911.63544182245;94655.52672236595;95398.52300738452;97253;98937;1013.6705570689555;1045.5765415006933;1049.464772965793;1061.1404762142688;1062.3466568060742;16633.750493742362;17035.40376086831;17166.39917602878;17253.654926901643;17710.20304086345;41448;41705.79147104245;41822.790886045375;41929.16141677088;42131.789341053096;55020;55409;55703.721481392335;56034;57103.42896570981;5487;6602.537822352389;7455.7017719290625;8480.957595211985;8569.914300856912;9459.432434053979;12007.579734709243;12533;12539.811902821648;12696.365181741061;10131.89868101339;10224.53989570486;10287.125594324567;10314.27800053989;10428.061474467335;10480.737981550523;10591.629292974709;10677.466126693478;10775.6228532001;10801;10376.74058148522;10423.739406514898;10446.895531044593;10562.89437105619;10624.84062739075;8286.4199506034;8458.365622578209;8472.40693151498;8673.392862499564;8713.607887644945;9347.43915365053;9644.18024467928;9948.651797187063;10085.495725213857;10249.9487502562 10:22:47 INFO - PROCESS | 3384 | |3;mootools.html;1514.8106486689164;1551.069358384969;1691.1375198648686;1801.0904493230917;1842.511734390386;9145.359824812265;9916.405015699054;9919.504024798758;9928;9932.056454636799;8463.492190468576;8751.3436492263;9163.312751543628;9409.764755881106;9443.622255109787;2444.3278098522915;2468.4325453337083;2472.7156377016695;2477.2196758021255;2477.4301910560494;2436.1595249638845;2497.787688046509;2510.5230006298743;2516.094206085808;2519.496100779842;2466.235467005234;2469.5678256305164;2473.0355161486946;2476.319012271622;2487.639292302615;2395.245497668229;2450.362905644545;2465.0632759551436;2473.0602371098958;2476.5170791695446;2442.218490083174;2455.4966231922413;2468.456939473313;2487.8009759219217;2488.0172331928966;9723.611055557769;9855.556499957447;9877.654282100091;9913.603455861758;9921.75195620108;5557.944420555783;5693.03218452864;5706.229658996024;5712.314522257356;5716;3360.1935535471557;3451.447768357051;3482.8780992665133;3493.336266109431;3530.6998905093096;1093.5024563823442;1110.3670907582682;1110.900018998286;1120.467777805536;1136.7555975465314;13370.39833207508;13424.194548327034;13446;13466.057375983684;13466.93266533661;4798.760061996886;4802.711837289774;4879.4876537963;4958.355413796256;5001.574866136347;11582.6525204244;11583.652490425133;11588.88411115878;11596;11661;5753.597248192586;5776.913346299809;5782.335031471351;5788.3343415506915;5791.160281759121;4512.661550383735;4544.909101817945;5117.437081920985;5190.299309593157;5299.33758280215;4465.531119232433;4481.775911204427;4549.909001819945;4580.862574122782;4613.76931153441;1328.2827273272517;1351.3783659516732;1355.6610847288177;1358.7690092684268;1369.1648094662248;1023.7491814505494;1054.6045233037612;1065.9200559957878;1074.6023971130576;1077.2513103393067;6485;6635.203775546869;6657.3009833966735;6829;6909.550879192836;448.6478114680026;455.96808223424705;457.2250036188695;459.11849249441156;503.81862529489354;4640.466346370143;4673.649476289292;4677.345171675968;4737.881552961204;4743.146233677971;11389.202755807013;11730.237534560227;11828.88171118295;11844.466998985066;11862.762744745056;11391.658250252505;11589.072874170046;11764.764704705858;11778.234414763014;11797.056235501312;8776.517291549026;8862.20240178387;8865.113488651083;8866.33502487316;8871.955640221757;6310.242770867525;6335.081413195153;6355.777547785805;6384.233891932998;6450.8064758057335;10696.786064278827;10941.179411544324;10965.835512467478;11013.339199648046;11028.172887033345;10748.516316765608;10792.568297268335;10823.458827058457;11014.788373279092;11191.944040279746;7505.286997735207;7775.688972441039;8280.089190189196;8326.625301861552;8488.236058754741;9401.717948461557;9524.904750952679;9525.190358819578;9525.809483810146;9532.23742100644;8422.073571907207;8445.366597505335;8477.95761021191;8482.448640838325;8492.278156356779;7969.442139050443;7979.48133371329;8242.670293188205;8243.299319557906;8260.339172866277;7494.138174110047;7655.660259454462;7656.578888161204;7707.961460192663;7714.190010048864;5340.5994550408095;5421.376541697755;5431.56547476193;5508.788066625336;5591.496765290981;5574.219609254626;5618.286422641134;5693.4021927696995;5705.600607957569;5746.051901436384 10:22:47 INFO - PROCESS | 3384 | |4;prototype.html;331.00037885585533;345.58874938822817;346.0587202808362;349.7272127740363;351.95776506819186;5315.7873685052555;5491.073882174244;5550.944490555098;5559.583031272656;5589.916151257735;5270.710110943896;5408.594355423349;5443;5449.209864569635;5452.263944367509;4262.147570485915;4274.230638485072;4283.635890949257;4285.571442855713;4294.012377153256;4183.723964190921;4237.643953934742;4259.70182087254;4282.507511636155;4294.377315289281;4233.915321693565;4238.80925358358;4245.044864905402;4245.363195520666;4255.1915136124035;4224.964883603521;4227.556106608808;4231.217224813388;4248.851290204828;4249.957500424987;3582.9641703582893;3718.981405092957;3722.4788529605876;3743.2139250757373;3778.3387907116144;5322.600804939645;5358.231783511432;5362.43694412085;5362.613636931567;5389.865253368658;4896.510348965111;4907.3009844585695;4915.311856340115;4918.434380046305;4960.33035540201;5644.576656750719;5678.2803545579245;5723.484886360206;5732.426757324276;5773.595848290622;4043.7961311085237;4045.289655930504;4051.412545180962;4063.1467391847746;4074.1851629674184;5998.820035398945;6004.7598096076545;6025.487833534155;6036.396360363972;6045;4050.837966481308;4203.222403855297;4245.511766146933;4259.850905218303;4262;4304.7632380218765;4310.31035034393;4333.674974376934;4356.477222733292;4362.411074504965;4928.328395345419;4931;4941.851744447672;4955.380577427822;4965.255211718271;5513.3108361454815;5807.303123625192;5828.970855145782;5848.356680765112;5874.765009399662;1417.7093695792337;1441.2793603198402;1450.6083357493628;1475.4212992098567;1476.8744656704087;965.9130678238993;971.218169373661;984.4487087231173;991.4497453913003;997.8624368220235;5594.692291923902;5605.411431799684;5622.943770562242;5623.6906970116215;5630.859228519238;5871.324797648325;5879.559982607256;5880.353161152269;5885.411458854081;5905.852353691193;5470.425605311385;5643.5767317451355;5667.914981275284;5704.058830293038;5712.0860662293835;3148;3150.7951983121025;3161.2413020874824;3173.698498642625;3177.6663450337383;5826.359100498942;6151.292601350902;6176.722047507873;6183.659898705524;6189.907151392733;6018.111306572782;6057.545684073712;6098.926365035909;6129.4177053180765;6137.447629713258;6172.407588812709;6207.213599704177;6209.316975132731;6211.068339748984;6218.315985241529;5681.545476361964;5966.642001479925;5999.560105574718;6011.879762404815;6022.307434645072;5881.4118588142555;5900.350961394329;5904.793332233351;5906.438888305604;5926.199963005111;5928.9110663339225;6172.179207133817;6178.7219575120125;6204.472619827366;6210.043836191585;4257.318828987347;4266.637335826365;4267.957320426756;4268.359746037995;4268.722533035343;5762.279715035621;5977.282726072899;5993.6104153231645;6019.759209631566;6019.969900150471;5603.355614104267;5733.31200255972;5772.624779389326;5847.210626565359;5860.501857342174;5823.4467725566;5832.571020100103;5833.183354330312;5836.941630583639;5859.531237500904;5652.660840349592;5739.799107031234;5790.826275211751;5791.884162316815;5802.547484246867;5841.780123553022;5853.268341457318;5857.4435428634215;5858.150568167506;5868.413158684098;5500.9174862377895;5683.488486036276;5703.545595873192;5705.516565692867;5718.628289161191 10:22:47 INFO - PROCESS | 3384 | |5;yui.html;783.2754701900741;797.968081276749;799.8040480082379;853.9274161696255;884.8849649545558;16173.676526469479;17323.74014389782;17480.912595437007;17511;17512.912435437822;15519.379224831022;15651.843481565182;15663.765043524329;15664.921675391606;15669.529914102566;708.0901042160824;733.9229380915007;856.6444925356001;867.4274978514181;880.7709995401178;887.8268737596139;889.208604342136;889.6930558957149;891.2201823404521;891.425030855098;934.9906500934972;940.5955439161158;942.9905700943006;943.009839668349;945.2910317262053;936.9578368973413;937.3953799799125;938.699616122841;938.7371535969974;939;687.4981263677494;688.9138857642795;689.5862482510504;690.0752990992045;690.547691262224;15248.31382587775;15275.541733748005;15296.923515382352;15449.459268925533;15597.298121584556;15809.841901580952;16629.334826606922;16743.16284185786;17070.48788536346;17633.823661763345;12571.371431428484;12715.427805748763;12717.809232861515;12890.935545322214;12911.483540658362;4096.283150448659;4113.239050775586;4121.402396652468;4147.6267135957905;4208.621224089847;73019.63490182515;74379.88430173497;84163.57918210431;84361;84997.60009599608;12010.63968080959;12452.252864828139;12747;12850.807237891438;12852.55016074433;22997.655035174485;23134.884325578263;23215.53568928612;23324.3002709919;23390.298291051295;9099.909000909905;9170.220531254785;9380.906190938003;9397.095189996779;9582.760430989281;4999.200127979506;5133.563647090039;5155.587552995751;5248.160294352885;5516.365617953987;3796.297684928242;3937.9606203938165;3939.9015024624614;3944.033711740642;3947.3289540778137;629.8866204083309;633.0851918977035;633.94294513494;661.8279247395711;669.1434963247052;669.7454967112564;675.42588799521;687.7249100359896;703.4407645921505;775.2092865277385;10275.588976441008;10360.222983276133;10407.479626018669;10906.61826836057;11107.611233606785;659.5613916745407;721.3183541553286;757.7423675950093;774.2605811450052;776.2354081229984;4477.440319960005;4842.9757851211225;4869.95130048695;4879.780409881564;4916.729579873141;71663.64168179125;107089.4645526783;130745;130928;137528;92784.53607731918;113722;117079;117473;119565.40217298857;58790.11814822781;80577;84282.29629222714;84415.57792211;95876.9999999986;10295.639652612123;10816.134709223401;10824.458777060958;10826.729331766768;10903.34579925207;38885;39071.218575628896;53276;54934.90130197453;55411.72294138504;25069.122580709587;25244.116455923955;51572.96854062973;79655.20344796478;81999;13889.305534723426;13933.651658708613;13981.23103229332;14079.859201407855;14168.858311416754;13907.304634768423;14053.789193162314;15108.54674359771;15635.843641563439;15889.602759931095;11720.88279117198;11866.940665296619;11879.10906681985;11979.04167666567;12190.390480476119;14374.928125359307;14628.414863405345;15189.43239960954;15362.308696108925;15694.686106278039;14242.145471271757;14281.42874285017;14970.251487425803;15684.451044213398;15883.364665413254;12165.817512737493;12495.875041249472;12709.682257943625;12942.223466592035;13157;12272.263664180178;12545;12659.746805064031;12808;12832.280367147545 10:22:47 INFO - PROCESS | 3384 | __end_tp_report 10:22:47 INFO - PROCESS | 3384 | __start_cc_report 10:22:47 INFO - PROCESS | 3384 | _x_x_mozilla_cycle_collect,853 10:22:47 INFO - PROCESS | 3384 | __end_cc_report 10:22:47 INFO - PROCESS | 3384 | __startTimestamp1483640567419__endTimestamp 10:22:47 INFO - PROCESS | 3384 | 10:22:47 INFO - PROCESS | 3384 | ------- Summary: start ------- 10:22:47 INFO - PROCESS | 3384 | Number of tests: 6 10:22:47 INFO - PROCESS | 3384 | 10:22:47 INFO - PROCESS | 3384 | [#0] dojo.html Cycles:165 Average:5590.33 Median:5807.65 stddev:637.36 (11.0%) stddev-sans-first:608.87 10:22:47 INFO - PROCESS | 3384 | Values: 3109.3 3161.0 3177.1 3190.0 3209.4 5530.6 5611.3 5614.1 5631.4 5639.5 5600.7 5642.8 5647.3 5648.2 5661.3 5110.3 5112.1 5146.8 5162.6 5181.2 5037.5 5067.3 5148.6 5199.7 5223.6 5049.5 5063.2 5068.4 5127.5 5128.6 5159.7 5169.9 5183.8 5252.8 5253.6 5051.0 5143.0 5206.2 5215.2 5237.9 5420.5 5468.6 5539.5 5581.7 5609.8 5993.5 6008.8 6113.4 6114.5 6116.3 6141.7 6151.6 6157.7 6158.0 6168.2 5475.0 5517.1 5538.3 5543.6 5551.7 6178.5 6189.7 6189.9 6190.1 6192.3 5908.4 5908.9 5919.9 5923.0 5928.9 5713.4 5721.8 5823.6 5832.4 5834.4 5887.1 5888.9 5892.9 5915.1 5932.2 5859.6 5881.5 5925.1 5927.1 5927.2 4496.6 4525.7 4568.3 4615.6 4634.4 4121.5 4139.2 4153.8 4162.3 4184.9 5785.1 5793.3 5796.3 5797.9 5807.7 5878.1 5926.4 5975.5 6048.8 6062.8 5768.4 5837.5 5849.5 5873.6 5874.8 5240.0 5275.1 5293.7 5294.2 5298.4 6080.2 6123.9 6164.4 6202.6 6217.5 5956.8 5983.1 6019.5 6077.0 6116.4 6184.5 6214.4 6217.3 6218.9 6289.4 5704.1 5960.9 5962.0 5969.3 6002.6 5795.1 5987.7 6031.4 6065.3 6146.8 5927.3 5967.8 5975.3 5984.4 6003.3 5946.3 5986.9 5990.2 5994.7 5998.3 5677.1 5774.7 5780.2 5813.1 5828.5 5921.9 5923.2 5924.9 5930.0 5952.6 5580.4 5762.9 5782.7 5784.7 5786.8 10:22:47 INFO - PROCESS | 3384 | 10:22:47 INFO - PROCESS | 3384 | [#1] ext.html Cycles:180 Average:62983.28 Median:192217.89 stddev:121884.92 (63.4%) stddev-sans-first:122136.83 10:22:47 INFO - PROCESS | 3384 | Values: 597.5 615.7 619.3 646.2 658.4 34709.3 37743.0 47257.0 48354.0 48530.3 49380.3 49848.8 49859.0 50039.5 50090.0 9316.2 9456.0 9456.1 9478.1 9484.9 8573.7 8787.4 11056.8 11293.7 11306.2 11342.5 11430.1 11443.3 11450.1 11451.3 11338.7 11360.9 11384.3 11422.7 11426.6 11281.2 11347.0 11347.1 11349.1 11357.4 45900.3 46209.0 46300.5 46328.8 46382.5 3759.5 3812.8 3948.1 4186.1 4446.6 34202.0 34404.0 34680.7 34742.7 35578.8 3651.8 3721.5 3756.7 3769.3 3805.5 372393.0 375205.0 378482.0 379872.0 380623.0 65095.7 65491.0 65528.0 65560.0 65660.3 41117.6 41613.2 41713.2 44488.3 67826.7 18194.4 18246.3 18272.4 18359.4 18359.5 12631.0 12877.8 13942.1 14046.3 14046.4 20511.6 21102.2 21194.9 21730.5 21751.8 7371.3 7567.3 7588.3 7600.9 7716.8 980.6 1032.0 1039.5 1108.5 1157.5 35106.6 35225.0 35270.8 35445.6 35580.0 1143.0 1159.0 1167.9 1176.7 1212.2 18436.9 18437.3 18550.5 18592.6 18673.4 562168.0 570289.0 570397.0 570780.0 571002.0 64486.7 65135.7 65490.7 65656.7 65840.3 1318.4 1367.7 1405.6 1409.3 1441.4 33918.5 35672.8 36002.8 36044.0 36309.3 55744.0 55890.7 56115.0 56327.4 56361.4 411750.0 411944.0 412162.0 413480.0 414320.0 28008.0 28023.6 28757.6 32309.4 32845.3 47465.0 51553.5 52704.7 52854.2 54455.2 42952.6 43619.0 44680.8 45592.5 45994.8 43740.6 44295.8 44663.6 45587.0 45976.8 43046.8 43047.0 43596.6 43602.6 43628.1 37377.8 39633.2 40064.2 40437.2 40861.8 29418.9 29626.0 30053.2 30219.4 30314.5 10:22:47 INFO - PROCESS | 3384 | 10:22:47 INFO - PROCESS | 3384 | [#2] jquery.html Cycles:180 Average:30492.22 Median:2411.63 stddev:91036.98 (3774.9%) stddev-sans-first:91264.37 10:22:47 INFO - PROCESS | 3384 | Values: 426.8 435.4 440.3 444.5 446.4 18797.3 20295.3 20365.9 20534.8 20703.6 19433.2 19865.7 19988.4 20067.9 20213.0 5632.0 5941.4 5942.5 5947.5 5948.4 5750.6 5783.4 5788.9 5790.8 5848.5 5744.0 5757.0 5762.7 5764.9 5771.5 5619.9 5864.1 5871.5 5893.8 5963.5 5697.7 5797.9 5801.0 5803.4 5828.9 14040.9 14471.6 14865.6 14869.9 14886.0 2405.7 2417.6 2477.9 2704.3 3045.8 10520.3 10628.6 12110.9 13203.3 15741.5 1913.3 1964.3 2036.8 2075.6 2088.9 59511.0 81754.0 87463.6 87607.0 88281.6 11768.5 11802.2 11894.5 11936.3 12066.1 17036.6 17124.5 17125.5 17132.6 17144.9 8216.1 8371.6 8423.5 8435.7 8464.6 7759.9 7775.9 7834.2 7906.7 7928.6 4974.8 5109.6 5121.2 5143.4 5182.2 1831.5 2037.8 2077.5 2148.5 2185.9 989.9 1000.6 1025.7 1060.1 1089.3 19469.8 19717.2 19794.6 19880.4 20264.8 1008.4 1010.2 1039.0 1060.5 1065.7 10561.7 10972.7 10986.1 11039.2 11093.8 539095.0 544078.0 554721.0 563914.0 566486.0 72911.6 94655.5 95398.5 97253.0 98937.0 1013.7 1045.6 1049.5 1061.1 1062.3 16633.8 17035.4 17166.4 17253.7 17710.2 41448.0 41705.8 41822.8 41929.2 42131.8 55020.0 55409.0 55703.7 56034.0 57103.4 5487.0 6602.5 7455.7 8481.0 8569.9 9459.4 12007.6 12533.0 12539.8 12696.4 10131.9 10224.5 10287.1 10314.3 10428.1 10480.7 10591.6 10677.5 10775.6 10801.0 10376.7 10423.7 10446.9 10562.9 10624.8 8286.4 8458.4 8472.4 8673.4 8713.6 9347.4 9644.2 9948.7 10085.5 10249.9 10:22:47 INFO - PROCESS | 3384 | 10:22:47 INFO - PROCESS | 3384 | [#3] mootools.html Cycles:180 Average:6272.87 Median:4627.12 stddev:3622.23 (78.3%) stddev-sans-first:3614.75 10:22:47 INFO - PROCESS | 3384 | Values: 1514.8 1551.1 1691.1 1801.1 1842.5 9145.4 9916.4 9919.5 9928.0 9932.1 8463.5 8751.3 9163.3 9409.8 9443.6 2444.3 2468.4 2472.7 2477.2 2477.4 2436.2 2497.8 2510.5 2516.1 2519.5 2466.2 2469.6 2473.0 2476.3 2487.6 2395.2 2450.4 2465.1 2473.1 2476.5 2442.2 2455.5 2468.5 2487.8 2488.0 9723.6 9855.6 9877.7 9913.6 9921.8 5557.9 5693.0 5706.2 5712.3 5716.0 3360.2 3451.4 3482.9 3493.3 3530.7 1093.5 1110.4 1110.9 1120.5 1136.8 13370.4 13424.2 13446.0 13466.1 13466.9 4798.8 4802.7 4879.5 4958.4 5001.6 11582.7 11583.7 11588.9 11596.0 11661.0 5753.6 5776.9 5782.3 5788.3 5791.2 4512.7 4544.9 5117.4 5190.3 5299.3 4465.5 4481.8 4549.9 4580.9 4613.8 1328.3 1351.4 1355.7 1358.8 1369.2 1023.7 1054.6 1065.9 1074.6 1077.3 6485.0 6635.2 6657.3 6829.0 6909.6 448.6 456.0 457.2 459.1 503.8 4640.5 4673.6 4677.3 4737.9 4743.1 11389.2 11730.2 11828.9 11844.5 11862.8 11391.7 11589.1 11764.8 11778.2 11797.1 8776.5 8862.2 8865.1 8866.3 8872.0 6310.2 6335.1 6355.8 6384.2 6450.8 10696.8 10941.2 10965.8 11013.3 11028.2 10748.5 10792.6 10823.5 11014.8 11191.9 7505.3 7775.7 8280.1 8326.6 8488.2 9401.7 9524.9 9525.2 9525.8 9532.2 8422.1 8445.4 8478.0 8482.4 8492.3 7969.4 7979.5 8242.7 8243.3 8260.3 7494.1 7655.7 7656.6 7708.0 7714.2 5340.6 5421.4 5431.6 5508.8 5591.5 5574.2 5618.3 5693.4 5705.6 5746.1 10:22:47 INFO - PROCESS | 3384 | 10:22:47 INFO - PROCESS | 3384 | [#4] prototype.html Cycles:180 Average:4875.09 Median:5614.18 stddev:1445.61 (25.7%) stddev-sans-first:1408.86 10:22:47 INFO - PROCESS | 3384 | Values: 331.0 345.6 346.1 349.7 352.0 5315.8 5491.1 5550.9 5559.6 5589.9 5270.7 5408.6 5443.0 5449.2 5452.3 4262.1 4274.2 4283.6 4285.6 4294.0 4183.7 4237.6 4259.7 4282.5 4294.4 4233.9 4238.8 4245.0 4245.4 4255.2 4225.0 4227.6 4231.2 4248.9 4250.0 3583.0 3719.0 3722.5 3743.2 3778.3 5322.6 5358.2 5362.4 5362.6 5389.9 4896.5 4907.3 4915.3 4918.4 4960.3 5644.6 5678.3 5723.5 5732.4 5773.6 4043.8 4045.3 4051.4 4063.1 4074.2 5998.8 6004.8 6025.5 6036.4 6045.0 4050.8 4203.2 4245.5 4259.9 4262.0 4304.8 4310.3 4333.7 4356.5 4362.4 4928.3 4931.0 4941.9 4955.4 4965.3 5513.3 5807.3 5829.0 5848.4 5874.8 1417.7 1441.3 1450.6 1475.4 1476.9 965.9 971.2 984.4 991.4 997.9 5594.7 5605.4 5622.9 5623.7 5630.9 5871.3 5879.6 5880.4 5885.4 5905.9 5470.4 5643.6 5667.9 5704.1 5712.1 3148.0 3150.8 3161.2 3173.7 3177.7 5826.4 6151.3 6176.7 6183.7 6189.9 6018.1 6057.5 6098.9 6129.4 6137.4 6172.4 6207.2 6209.3 6211.1 6218.3 5681.5 5966.6 5999.6 6011.9 6022.3 5881.4 5900.4 5904.8 5906.4 5926.2 5928.9 6172.2 6178.7 6204.5 6210.0 4257.3 4266.6 4268.0 4268.4 4268.7 5762.3 5977.3 5993.6 6019.8 6020.0 5603.4 5733.3 5772.6 5847.2 5860.5 5823.4 5832.6 5833.2 5836.9 5859.5 5652.7 5739.8 5790.8 5791.9 5802.5 5841.8 5853.3 5857.4 5858.2 5868.4 5500.9 5683.5 5703.5 5705.5 5718.6 10:22:47 INFO - PROCESS | 3384 | 10:22:47 INFO - PROCESS | 3384 | [#5] yui.html Cycles:180 Average:20983.28 Median:21340.65 stddev:30521.71 (143.0%) stddev-sans-first:30569.65 10:22:47 INFO - PROCESS | 3384 | Values: 783.3 798.0 799.8 853.9 884.9 16173.7 17323.7 17480.9 17511.0 17512.9 15519.4 15651.8 15663.8 15664.9 15669.5 708.1 733.9 856.6 867.4 880.8 887.8 889.2 889.7 891.2 891.4 935.0 940.6 943.0 943.0 945.3 937.0 937.4 938.7 938.7 939.0 687.5 688.9 689.6 690.1 690.5 15248.3 15275.5 15296.9 15449.5 15597.3 15809.8 16629.3 16743.2 17070.5 17633.8 12571.4 12715.4 12717.8 12890.9 12911.5 4096.3 4113.2 4121.4 4147.6 4208.6 73019.6 74379.9 84163.6 84361.0 84997.6 12010.6 12452.3 12747.0 12850.8 12852.6 22997.7 23134.9 23215.5 23324.3 23390.3 9099.9 9170.2 9380.9 9397.1 9582.8 4999.2 5133.6 5155.6 5248.2 5516.4 3796.3 3938.0 3939.9 3944.0 3947.3 629.9 633.1 633.9 661.8 669.1 669.7 675.4 687.7 703.4 775.2 10275.6 10360.2 10407.5 10906.6 11107.6 659.6 721.3 757.7 774.3 776.2 4477.4 4843.0 4870.0 4879.8 4916.7 71663.6 107089.5 130745.0 130928.0 137528.0 92784.5 113722.0 117079.0 117473.0 119565.4 58790.1 80577.0 84282.3 84415.6 95877.0 10295.6 10816.1 10824.5 10826.7 10903.3 38885.0 39071.2 53276.0 54934.9 55411.7 25069.1 25244.1 51573.0 79655.2 81999.0 13889.3 13933.7 13981.2 14079.9 14168.9 13907.3 14053.8 15108.5 15635.8 15889.6 11720.9 11866.9 11879.1 11979.0 12190.4 14374.9 14628.4 15189.4 15362.3 15694.7 14242.1 14281.4 14970.3 15684.5 15883.4 12165.8 12495.9 12709.7 12942.2 13157.0 12272.3 12545.0 12659.7 12808.0 12832.3 10:22:47 INFO - PROCESS | 3384 | -------- Summary: end -------- 10:22:47 INFO - PROCESS | 3384 | 10:22:48 INFO - TEST-INFO | 3384: exit 0 10:22:48 INFO - TEST-OK | dromaeo_css | took 1115601ms 10:22:48 INFO - TEST-START | kraken 10:22:48 INFO - operating with platform_type : linux_ 10:22:48 INFO - Initialising browser for kraken test... 10:22:48 INFO - TEST-INFO | started process 3686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa2Gz6L/profile http://localhost:42359/getInfo.html) 10:22:52 INFO - PROCESS | 3686 | __metrics Screen width/height:1600/1200 10:22:52 INFO - PROCESS | 3686 | colorDepth:24 10:22:52 INFO - PROCESS | 3686 | Browser inner width/height: 1024/697 10:22:52 INFO - PROCESS | 3686 | __metrics 10:22:53 INFO - PROCESS | 3686 | 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" 10:22:53 INFO - PROCESS | 3686 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:22:53 INFO - PROCESS | 3686 | console.error: PushService: 10:22:53 INFO - PROCESS | 3686 | stateChangeProcessEnqueue: Error transitioning state 10:22:53 INFO - PROCESS | 3686 | UnknownError 10:22:54 INFO - TEST-INFO | 3686: exit 0 10:22:54 INFO - Browser initialized. 10:22:54 INFO - Running cycle 1/1 for kraken test... 10:22:54 INFO - TEST-INFO | started process 3781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa2Gz6L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:06 INFO - PROCESS | 3781 | RSS: Main: 143032320 10:23:06 INFO - PROCESS | 3781 | 10:23:08 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42359/tests/kraken/driver.html?testName=audio-beat-detection) 10:23:09 INFO - PROCESS | 3781 | RSS: Main: 186335232 10:23:09 INFO - PROCESS | 3781 | 10:23:11 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42359/tests/kraken/driver.html?testName=audio-dft) 10:23:12 INFO - PROCESS | 3781 | RSS: Main: 174206976 10:23:12 INFO - PROCESS | 3781 | 10:23:15 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42359/tests/kraken/driver.html?testName=audio-fft) 10:23:15 INFO - PROCESS | 3781 | RSS: Main: 265850880 10:23:15 INFO - PROCESS | 3781 | 10:23:17 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42359/tests/kraken/driver.html?testName=audio-oscillator) 10:23:18 INFO - PROCESS | 3781 | RSS: Main: 172523520 10:23:18 INFO - PROCESS | 3781 | 10:23:20 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:23:21 INFO - PROCESS | 3781 | RSS: Main: 173486080 10:23:21 INFO - PROCESS | 3781 | 10:23:24 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42359/tests/kraken/driver.html?testName=imaging-darkroom) 10:23:24 INFO - PROCESS | 3781 | RSS: Main: 209555456 10:23:24 INFO - PROCESS | 3781 | 10:23:27 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42359/tests/kraken/driver.html?testName=imaging-desaturate) 10:23:28 INFO - PROCESS | 3781 | RSS: Main: 208560128 10:23:28 INFO - PROCESS | 3781 | 10:23:31 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42359/tests/kraken/driver.html?testName=json-parse-financial) 10:23:31 INFO - PROCESS | 3781 | RSS: Main: 208703488 10:23:31 INFO - PROCESS | 3781 | 10:23:33 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:23:33 INFO - PROCESS | 3781 | RSS: Main: 170479616 10:23:33 INFO - PROCESS | 3781 | 10:23:35 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:23:36 INFO - PROCESS | 3781 | RSS: Main: 177508352 10:23:36 INFO - PROCESS | 3781 | 10:23:38 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:23:38 INFO - PROCESS | 3781 | RSS: Main: 187355136 10:23:38 INFO - PROCESS | 3781 | 10:23:41 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:23:42 INFO - PROCESS | 3781 | RSS: Main: 195997696 10:23:42 INFO - PROCESS | 3781 | 10:23:44 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:23:45 INFO - PROCESS | 3781 | RSS: Main: 192696320 10:23:45 INFO - PROCESS | 3781 | 10:23:46 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:42359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42359/tests/kraken/driver.html?testName=ai-astar) 10:23:47 INFO - PROCESS | 3781 | RSS: Main: 244117504 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | __start_tp_report 10:23:47 INFO - PROCESS | 3781 | _x_x_mozilla_page_load 10:23:47 INFO - PROCESS | 3781 | _x_x_mozilla_page_load_details 10:23:47 INFO - PROCESS | 3781 | |i|pagename|runs| 10:23:47 INFO - PROCESS | 3781 | |0;ai-astar;110;111;109;110;111;110;109;109;110;110 10:23:47 INFO - PROCESS | 3781 | |1;audio-beat-detection;146;119;119;158;120;117;117;116;145;118 10:23:47 INFO - PROCESS | 3781 | |2;audio-dft;161;159;161;159;159;158;160;162;162;158 10:23:47 INFO - PROCESS | 3781 | |3;audio-fft;74;76;75;109;75;77;76;76;99;74 10:23:47 INFO - PROCESS | 3781 | |4;audio-oscillator;82;81;111;80;81;80;99;81;81;111 10:23:47 INFO - PROCESS | 3781 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;116;116;117 10:23:47 INFO - PROCESS | 3781 | |6;imaging-darkroom;146;145;146;146;146;146;145;147;147;145 10:23:47 INFO - PROCESS | 3781 | |7;imaging-desaturate;95;94;95;96;96;95;95;95;95;96 10:23:47 INFO - PROCESS | 3781 | |8;json-parse-financial;54;52;53;51;53;50;52;55;51;51 10:23:47 INFO - PROCESS | 3781 | |9;json-stringify-tinderbox;59;59;59;59;59;59;58;59;59;59 10:23:47 INFO - PROCESS | 3781 | |10;stanford-crypto-aes;77;80;74;78;78;74;73;73;74;72 10:23:47 INFO - PROCESS | 3781 | |11;stanford-crypto-ccm;121;121;122;123;121;124;121;122;161;129 10:23:47 INFO - PROCESS | 3781 | |12;stanford-crypto-pbkdf2;159;159;157;154;155;154;155;156;153;154 10:23:47 INFO - PROCESS | 3781 | |13;stanford-crypto-sha256-iterative;67;64;66;61;61;62;61;64;61;64 10:23:47 INFO - PROCESS | 3781 | __end_tp_report 10:23:47 INFO - PROCESS | 3781 | __start_cc_report 10:23:47 INFO - PROCESS | 3781 | _x_x_mozilla_cycle_collect,1591 10:23:47 INFO - PROCESS | 3781 | __end_cc_report 10:23:47 INFO - PROCESS | 3781 | __startTimestamp1483640627120__endTimestamp 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | ------- Summary: start ------- 10:23:47 INFO - PROCESS | 3781 | Number of tests: 14 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 10:23:47 INFO - PROCESS | 3781 | Values: 110.0 111.0 109.0 110.0 111.0 110.0 109.0 109.0 110.0 110.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:119.50 stddev:15.71 (13.2%) stddev-sans-first:15.17 10:23:47 INFO - PROCESS | 3781 | Values: 146.0 119.0 119.0 158.0 120.0 117.0 117.0 116.0 145.0 118.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.50 stddev:1.52 (0.9%) stddev-sans-first:1.56 10:23:47 INFO - PROCESS | 3781 | Values: 161.0 159.0 161.0 159.0 159.0 158.0 160.0 162.0 162.0 158.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:12.33 (16.2%) stddev-sans-first:12.81 10:23:47 INFO - PROCESS | 3781 | Values: 74.0 76.0 75.0 109.0 75.0 77.0 76.0 76.0 99.0 74.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:81.00 stddev:13.06 (16.1%) stddev-sans-first:13.62 10:23:47 INFO - PROCESS | 3781 | Values: 82.0 81.0 111.0 80.0 81.0 80.0 99.0 81.0 81.0 111.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:23:47 INFO - PROCESS | 3781 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:23:47 INFO - PROCESS | 3781 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 145.0 147.0 147.0 145.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:23:47 INFO - PROCESS | 3781 | Values: 95.0 94.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:1.55 (3.0%) stddev-sans-first:1.50 10:23:47 INFO - PROCESS | 3781 | Values: 54.0 52.0 53.0 51.0 53.0 50.0 52.0 55.0 51.0 51.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 10:23:47 INFO - PROCESS | 3781 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 59.0 59.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.50 stddev:2.71 (3.6%) stddev-sans-first:2.80 10:23:47 INFO - PROCESS | 3781 | Values: 77.0 80.0 74.0 78.0 78.0 74.0 73.0 73.0 74.0 72.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:122.50 stddev:12.37 (10.1%) stddev-sans-first:12.96 10:23:47 INFO - PROCESS | 3781 | Values: 121.0 121.0 122.0 123.0 121.0 124.0 121.0 122.0 161.0 129.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:155.50 stddev:2.12 (1.4%) stddev-sans-first:1.86 10:23:47 INFO - PROCESS | 3781 | Values: 159.0 159.0 157.0 154.0 155.0 154.0 155.0 156.0 153.0 154.0 10:23:47 INFO - PROCESS | 3781 | 10:23:47 INFO - PROCESS | 3781 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:64.00 stddev:2.23 (3.5%) stddev-sans-first:1.87 10:23:47 INFO - PROCESS | 3781 | Values: 67.0 64.0 66.0 61.0 61.0 62.0 61.0 64.0 61.0 64.0 10:23:47 INFO - PROCESS | 3781 | -------- Summary: end -------- 10:23:47 INFO - PROCESS | 3781 | 10:23:48 INFO - TEST-INFO | 3781: exit 0 10:23:48 INFO - TEST-OK | kraken | took 59949ms 10:23:48 INFO - SUITE-END | took 1175s 10:23:48 INFO - Completed test suite (00:19:35) 10:23:48 INFO - javascript benchmark 10:23:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.331493728848, 3161.0200837740294, 3177.110409085457, 3190.011096560068, 3209.422303985283, 5530.6128571, 5611.3266408030995, 5614.129809879475, 5631.380548139707, 5639.520640745536, 5600.691961942091, 5642.802501912434, 5647.29408823897, 5648.209250704905, 5661.3206415230125, 5110.335656364668, 5112.054269960051, 5146.768395422197, 5162.561182299509, 5181.1710126379785, 5037.496250374951, 5067.315912351841, 5148.613853960949, 5199.722973747282, 5223.63434559579, 5049.4698056704065, 5063.215201643733, 5068.417132029808, 5127.461616530267, 5128.615353848458, 5159.690418574897, 5169.922451163236, 5183.792648294064, 5252.842414727526, 5253.579713622901, 5051.0, 5142.974285128588, 5206.167013277895, 5215.217717342391, 5237.895242095175, 5420.4850539198715, 5468.644538105011, 5539.473749993744, 5581.6930068846195, 5609.831705048855, 5993.490553302974, 6008.789692360747, 6113.449789518964, 6114.480269177081, 6116.327204007555, 6141.723622437001, 6151.569390142692, 6157.692115394212, 6158.04550294705, 6168.198134242564, 5474.972625136849, 5517.144842549411, 5538.280023596987, 5543.556515478833, 5551.666899986014, 6178.474829639441, 6189.690515474208, 6189.907151392733, 6190.071489276645, 6192.287886893065, 5908.350081491032, 5908.852278693067, 5919.852003699856, 5923.0, 5928.881422371528, 5713.428657134336, 5721.799737009268, 5823.56323275756, 5832.416758324219, 5834.38738932406, 5887.0580707086665, 5888.911666325009, 5892.94107058924, 5915.053591425351, 5932.169496270526, 5859.648421094748, 5881.529477641779, 5925.111233315038, 5927.081302398135, 5927.229460170151, 4496.64026877849, 4525.683202175816, 4568.269076947672, 4615.630749540029, 4634.37435946143, 4121.464209652726, 4139.234241665302, 4153.792310384469, 4162.313218319004, 4184.8744537663915, 5785.10330898703, 5793.333766616893, 5796.304443466811, 5797.88404231913, 5807.651540907559, 5878.118282257696, 5926.407359264125, 5975.492083172892, 6048.758049677964, 6062.818115456544, 5768.423157684198, 5837.47462728348, 5849.502792262705, 5873.559483038789, 5874.794382196688, 5240.0, 5275.103232450492, 5293.655912365684, 5294.23233631129, 5298.364196296392, 6080.209572755602, 6123.908141377794, 6164.4143806338325, 6202.596831206048, 6217.533684973555, 5956.821295361146, 5983.1025346196675, 6019.458248757633, 6076.969615151896, 6116.357782432959, 6184.505239580732, 6214.440700336811, 6217.253929528486, 6218.875622487434, 6289.433950944437, 5704.087346024616, 5960.8807823844145, 5962.016267315845, 5969.313528944053, 6002.609830361012, 5795.1017592273265, 5987.700614969147, 6031.366706495754, 6065.272167339947, 6146.815595532141, 5927.288725352985, 5967.8209653710455, 5975.312839023568, 5984.431479009487, 6003.309619393825, 5946.256717910262, 5986.9401305986385, 5990.161377407254, 5994.70026498682, 5998.25021872266, 5677.148427735872, 5774.653520788766, 5780.190773291826, 5813.069908814569, 5828.533717302521, 5921.851953701192, 5923.200367950271, 5924.851878702894, 5930.021546444961, 5952.5833191676165, 5580.441955804387, 5762.855928601818, 5782.653040817564, 5784.710764461676, 5786.826395208151], "value": 5546.423320049986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.4652685846168, 615.7352338494447, 619.2940048344885, 646.1987135951418, 658.3844105761113, 34709.30581388371, 37743.0, 47256.999999999956, 48354.0, 48530.27204591925, 49380.259296110584, 49848.750756246256, 49859.0, 50039.49960500394, 50089.994600324004, 9316.208122309596, 9455.95272023639, 9456.054394560557, 9478.052194780501, 9484.905150948505, 8573.74278771638, 8787.384883058157, 11056.834147487794, 11293.661190164308, 11306.152038597096, 11342.546298148065, 11430.08559315257, 11443.256188347772, 11450.08399328056, 11451.312921224711, 11338.659840204766, 11360.886391136148, 11384.316940983485, 11422.657320280363, 11426.600068997586, 11281.153913456441, 11347.0, 11347.148963827745, 11349.09207263417, 11357.375344356056, 45900.311495327594, 46209.0, 46300.53699462996, 46328.768356158005, 46382.53617463816, 3759.548854137521, 3812.7712337259854, 3948.072203032285, 4186.099988502456, 4446.57757513039, 34201.973940781565, 34404.0, 34680.65319346825, 34742.65257347445, 35578.8221058893, 3651.8174091295327, 3721.497597824286, 3756.7370284080125, 3769.340365436065, 3805.486259354979, 372393.0, 375205.0, 378482.0, 379872.0, 380623.0, 65095.67452162803, 65491.0, 65528.0, 65560.0, 65660.34339656637, 41117.588824111976, 41613.1677366451, 41713.1657366851, 44488.3326750099, 67826.66086669634, 18194.363197288032, 18246.270149194148, 18272.360467383576, 18359.449216523524, 18359.54101147482, 12631.0, 12877.806832897513, 13942.093763905314, 14046.297685115907, 14046.367913443919, 20511.58976820455, 21102.155913763276, 21194.894025529775, 21730.456738581346, 21751.782482174975, 7371.336579707852, 7567.281108294703, 7588.27911348421, 7600.885986710204, 7716.7684969451, 980.5587485631495, 1032.0453580438216, 1039.542601255445, 1108.4845546820607, 1157.5369852059243, 35106.64893351085, 35225.0, 35270.8236458816, 35445.64554354475, 35580.0, 1142.9942850285695, 1158.9652310430702, 1167.9007284380923, 1176.7469993951343, 1212.1757205100616, 18436.907815460836, 18437.26250949947, 18550.536236594195, 18592.628147436975, 18673.439796805847, 562168.0, 570289.0, 570397.0, 570780.0, 571002.0, 64486.6775666128, 65135.67432162809, 65490.67254663696, 65656.67171664111, 65840.34159658341, 1318.3935389720643, 1367.746966811143, 1405.641561401836, 1409.2883094037445, 1441.3946142620125, 33918.491222632176, 35672.821635892695, 36002.8199858999, 36044.0, 36309.27381452409, 55744.0, 55890.72054639701, 56115.0, 56327.43672563222, 56361.43638563562, 411750.0, 411944.0, 412162.0, 413480.0, 414320.0, 28008.0, 28023.579646304916, 28757.56863647089, 32309.35381292408, 32845.343093137526, 47465.0, 51553.48446515487, 52704.7364763189, 52854.20718689146, 54455.18317225166, 42952.57047429486, 43619.0, 44680.77659611681, 45592.54407455883, 45994.770026150996, 43740.56259437365, 44295.77852110719, 44663.55336446594, 45587.0, 45976.77011614921, 43046.784766077224, 43047.0, 43596.56403435925, 43602.56397435985, 43628.12743745171, 37377.81311093427, 39633.2073358537, 40064.197111129484, 40437.1912561753, 40861.795691021354, 29418.852905735333, 29625.963091291702, 30053.248668783457, 30219.395612088076, 30314.545281821232], "value": 21656.970040517826, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.8442018663185, 435.4382846128494, 440.33289566307053, 444.52657919315925, 446.44194756554316, 18797.34209302673, 20295.289664861695, 20365.89817050913, 20534.79465205351, 20703.585928281424, 19433.222671093175, 19865.702014469796, 19988.400347989547, 20067.899660501676, 20213.0, 5631.971840140794, 5941.405859414067, 5942.465178133967, 5947.464728174464, 5948.43489868464, 5750.597458177929, 5783.392743761908, 5788.942110578903, 5790.7683692652245, 5848.4736373726355, 5744.0235160022685, 5757.0, 5762.7406766695385, 5764.855878603047, 5771.451712087366, 5619.859503512424, 5864.1203819427, 5871.530277577784, 5893.764249430018, 5963.493103086243, 5697.658140511582, 5797.942020579824, 5801.0428279333855, 5803.448672376117, 5828.941710582924, 14040.929795350958, 14471.565853024425, 14865.628359290997, 14869.925650371679, 14886.032407893452, 2405.675233843426, 2417.589009868309, 2477.863717495537, 2704.2968828104836, 3045.8477076146105, 10520.267029101382, 10628.627998020032, 12110.939445302716, 13203.2738199399, 15741.527754167393, 1913.292081929681, 1964.2732189089986, 2036.775954644988, 2075.6263872502946, 2088.9477763056043, 59511.0, 81754.0, 87463.56268218682, 87607.0, 88281.55859220662, 11768.470418831002, 11802.232854864405, 11894.464749086312, 11936.28382297065, 12066.09504287182, 17036.57408564771, 17124.486265411808, 17125.48623541296, 17132.571685707706, 17144.914275428542, 8216.055153657286, 8371.623276952552, 8423.536705481258, 8435.662573496991, 8464.619092140869, 7759.883601745978, 7775.883361749578, 7834.218852307463, 7906.683732650745, 7928.6035698214855, 4974.776135073858, 5109.616778741535, 5121.231815227746, 5143.4085080216255, 5182.24857395683, 1831.541895775139, 2037.7758446570865, 2077.480629842539, 2148.5058436559366, 2185.8579192352445, 989.9356541824758, 1000.6047611193537, 1025.7223414218413, 1060.125396547851, 1089.2647462962468, 19469.805301947083, 19717.211311547377, 19794.60410791776, 19880.403587892386, 20264.797352026584, 1008.3899240959261, 1010.242318261304, 1038.984415233772, 1060.4591658254346, 1065.6909496246158, 10561.735956601147, 10972.670819875257, 10986.121110311156, 11039.227254092137, 11093.778124437627, 539095.0, 544078.0, 554721.0, 563914.0, 566486.0, 72911.63544182245, 94655.52672236595, 95398.52300738452, 97253.0, 98937.0, 1013.6705570689555, 1045.5765415006933, 1049.464772965793, 1061.1404762142688, 1062.3466568060742, 16633.750493742362, 17035.40376086831, 17166.39917602878, 17253.654926901643, 17710.20304086345, 41448.0, 41705.79147104245, 41822.790886045375, 41929.16141677088, 42131.789341053096, 55020.0, 55409.0, 55703.721481392335, 56034.0, 57103.42896570981, 5487.0, 6602.537822352389, 7455.7017719290625, 8480.957595211985, 8569.914300856912, 9459.432434053979, 12007.579734709243, 12533.0, 12539.811902821648, 12696.365181741061, 10131.89868101339, 10224.53989570486, 10287.125594324567, 10314.27800053989, 10428.061474467335, 10480.737981550523, 10591.629292974709, 10677.466126693478, 10775.6228532001, 10801.0, 10376.74058148522, 10423.739406514898, 10446.895531044593, 10562.89437105619, 10624.84062739075, 8286.4199506034, 8458.365622578209, 8472.40693151498, 8673.392862499564, 8713.607887644945, 9347.43915365053, 9644.18024467928, 9948.651797187063, 10085.495725213857, 10249.9487502562], "value": 9215.943119874142, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.8106486689164, 1551.069358384969, 1691.1375198648686, 1801.0904493230917, 1842.511734390386, 9145.359824812265, 9916.405015699054, 9919.504024798758, 9928.0, 9932.056454636799, 8463.492190468576, 8751.3436492263, 9163.312751543628, 9409.764755881106, 9443.622255109787, 2444.3278098522915, 2468.4325453337083, 2472.7156377016695, 2477.2196758021255, 2477.4301910560494, 2436.1595249638845, 2497.787688046509, 2510.5230006298743, 2516.094206085808, 2519.496100779842, 2466.235467005234, 2469.5678256305164, 2473.0355161486946, 2476.319012271622, 2487.639292302615, 2395.245497668229, 2450.362905644545, 2465.0632759551436, 2473.0602371098958, 2476.5170791695446, 2442.218490083174, 2455.4966231922413, 2468.456939473313, 2487.8009759219217, 2488.0172331928966, 9723.611055557769, 9855.556499957447, 9877.654282100091, 9913.603455861758, 9921.75195620108, 5557.944420555783, 5693.03218452864, 5706.229658996024, 5712.314522257356, 5716.0, 3360.1935535471557, 3451.447768357051, 3482.8780992665133, 3493.336266109431, 3530.6998905093096, 1093.5024563823442, 1110.3670907582682, 1110.900018998286, 1120.467777805536, 1136.7555975465314, 13370.39833207508, 13424.194548327034, 13446.0, 13466.057375983684, 13466.93266533661, 4798.760061996886, 4802.711837289774, 4879.4876537963, 4958.355413796256, 5001.574866136347, 11582.6525204244, 11583.652490425133, 11588.88411115878, 11596.0, 11661.0, 5753.597248192586, 5776.913346299809, 5782.335031471351, 5788.3343415506915, 5791.160281759121, 4512.661550383735, 4544.909101817945, 5117.437081920985, 5190.299309593157, 5299.33758280215, 4465.531119232433, 4481.775911204427, 4549.909001819945, 4580.862574122782, 4613.76931153441, 1328.2827273272517, 1351.3783659516732, 1355.6610847288177, 1358.7690092684268, 1369.1648094662248, 1023.7491814505494, 1054.6045233037612, 1065.9200559957878, 1074.6023971130576, 1077.2513103393067, 6485.0, 6635.203775546869, 6657.3009833966735, 6829.0, 6909.550879192836, 448.6478114680026, 455.96808223424705, 457.2250036188695, 459.11849249441156, 503.81862529489354, 4640.466346370143, 4673.649476289292, 4677.345171675968, 4737.881552961204, 4743.146233677971, 11389.202755807013, 11730.237534560227, 11828.88171118295, 11844.466998985066, 11862.762744745056, 11391.658250252505, 11589.072874170046, 11764.764704705858, 11778.234414763014, 11797.056235501312, 8776.517291549026, 8862.20240178387, 8865.113488651083, 8866.33502487316, 8871.955640221757, 6310.242770867525, 6335.081413195153, 6355.777547785805, 6384.233891932998, 6450.8064758057335, 10696.786064278827, 10941.179411544324, 10965.835512467478, 11013.339199648046, 11028.172887033345, 10748.516316765608, 10792.568297268335, 10823.458827058457, 11014.788373279092, 11191.944040279746, 7505.286997735207, 7775.688972441039, 8280.089190189196, 8326.625301861552, 8488.236058754741, 9401.717948461557, 9524.904750952679, 9525.190358819578, 9525.809483810146, 9532.23742100644, 8422.073571907207, 8445.366597505335, 8477.95761021191, 8482.448640838325, 8492.278156356779, 7969.442139050443, 7979.48133371329, 8242.670293188205, 8243.299319557906, 8260.339172866277, 7494.138174110047, 7655.660259454462, 7656.578888161204, 7707.961460192663, 7714.190010048864, 5340.5994550408095, 5421.376541697755, 5431.56547476193, 5508.788066625336, 5591.496765290981, 5574.219609254626, 5618.286422641134, 5693.4021927696995, 5705.600607957569, 5746.051901436384], "value": 4900.481185474702, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.00037885585533, 345.58874938822817, 346.0587202808362, 349.7272127740363, 351.95776506819186, 5315.7873685052555, 5491.073882174244, 5550.944490555098, 5559.583031272656, 5589.916151257735, 5270.710110943896, 5408.594355423349, 5443.0, 5449.209864569635, 5452.263944367509, 4262.147570485915, 4274.230638485072, 4283.635890949257, 4285.571442855713, 4294.012377153256, 4183.723964190921, 4237.643953934742, 4259.70182087254, 4282.507511636155, 4294.377315289281, 4233.915321693565, 4238.80925358358, 4245.044864905402, 4245.363195520666, 4255.1915136124035, 4224.964883603521, 4227.556106608808, 4231.217224813388, 4248.851290204828, 4249.957500424987, 3582.9641703582893, 3718.981405092957, 3722.4788529605876, 3743.2139250757373, 3778.3387907116144, 5322.600804939645, 5358.231783511432, 5362.43694412085, 5362.613636931567, 5389.865253368658, 4896.510348965111, 4907.3009844585695, 4915.311856340115, 4918.434380046305, 4960.33035540201, 5644.576656750719, 5678.2803545579245, 5723.484886360206, 5732.426757324276, 5773.595848290622, 4043.7961311085237, 4045.289655930504, 4051.412545180962, 4063.1467391847746, 4074.1851629674184, 5998.820035398945, 6004.7598096076545, 6025.487833534155, 6036.396360363972, 6045.0, 4050.837966481308, 4203.222403855297, 4245.511766146933, 4259.850905218303, 4262.0, 4304.7632380218765, 4310.31035034393, 4333.674974376934, 4356.477222733292, 4362.411074504965, 4928.328395345419, 4931.0, 4941.851744447672, 4955.380577427822, 4965.255211718271, 5513.3108361454815, 5807.303123625192, 5828.970855145782, 5848.356680765112, 5874.765009399662, 1417.7093695792337, 1441.2793603198402, 1450.6083357493628, 1475.4212992098567, 1476.8744656704087, 965.9130678238993, 971.218169373661, 984.4487087231173, 991.4497453913003, 997.8624368220235, 5594.692291923902, 5605.411431799684, 5622.943770562242, 5623.6906970116215, 5630.859228519238, 5871.324797648325, 5879.559982607256, 5880.353161152269, 5885.411458854081, 5905.852353691193, 5470.425605311385, 5643.5767317451355, 5667.914981275284, 5704.058830293038, 5712.0860662293835, 3148.0, 3150.7951983121025, 3161.2413020874824, 3173.698498642625, 3177.6663450337383, 5826.359100498942, 6151.292601350902, 6176.722047507873, 6183.659898705524, 6189.907151392733, 6018.111306572782, 6057.545684073712, 6098.926365035909, 6129.4177053180765, 6137.447629713258, 6172.407588812709, 6207.213599704177, 6209.316975132731, 6211.068339748984, 6218.315985241529, 5681.545476361964, 5966.642001479925, 5999.560105574718, 6011.879762404815, 6022.307434645072, 5881.4118588142555, 5900.350961394329, 5904.793332233351, 5906.438888305604, 5926.199963005111, 5928.9110663339225, 6172.179207133817, 6178.7219575120125, 6204.472619827366, 6210.043836191585, 4257.318828987347, 4266.637335826365, 4267.957320426756, 4268.359746037995, 4268.722533035343, 5762.279715035621, 5977.282726072899, 5993.6104153231645, 6019.759209631566, 6019.969900150471, 5603.355614104267, 5733.31200255972, 5772.624779389326, 5847.210626565359, 5860.501857342174, 5823.4467725566, 5832.571020100103, 5833.183354330312, 5836.941630583639, 5859.531237500904, 5652.660840349592, 5739.799107031234, 5790.826275211751, 5791.884162316815, 5802.547484246867, 5841.780123553022, 5853.268341457318, 5857.4435428634215, 5858.150568167506, 5868.413158684098, 5500.9174862377895, 5683.488486036276, 5703.545595873192, 5705.516565692867, 5718.628289161191], "value": 4413.021116815022, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.2754701900741, 797.968081276749, 799.8040480082379, 853.9274161696255, 884.8849649545558, 16173.676526469479, 17323.74014389782, 17480.912595437007, 17511.0, 17512.912435437822, 15519.379224831022, 15651.843481565182, 15663.765043524329, 15664.921675391606, 15669.529914102566, 708.0901042160824, 733.9229380915007, 856.6444925356001, 867.4274978514181, 880.7709995401178, 887.8268737596139, 889.208604342136, 889.6930558957149, 891.2201823404521, 891.425030855098, 934.9906500934972, 940.5955439161158, 942.9905700943006, 943.009839668349, 945.2910317262053, 936.9578368973413, 937.3953799799125, 938.699616122841, 938.7371535969974, 939.0, 687.4981263677494, 688.9138857642795, 689.5862482510504, 690.0752990992045, 690.547691262224, 15248.31382587775, 15275.541733748005, 15296.923515382352, 15449.459268925533, 15597.298121584556, 15809.841901580952, 16629.334826606922, 16743.16284185786, 17070.48788536346, 17633.823661763345, 12571.371431428484, 12715.427805748763, 12717.809232861515, 12890.935545322214, 12911.483540658362, 4096.283150448659, 4113.239050775586, 4121.402396652468, 4147.6267135957905, 4208.621224089847, 73019.63490182515, 74379.88430173497, 84163.57918210431, 84361.0, 84997.60009599608, 12010.63968080959, 12452.252864828139, 12747.0, 12850.807237891438, 12852.55016074433, 22997.655035174485, 23134.884325578263, 23215.53568928612, 23324.3002709919, 23390.298291051295, 9099.909000909905, 9170.220531254785, 9380.906190938003, 9397.095189996779, 9582.760430989281, 4999.200127979506, 5133.563647090039, 5155.587552995751, 5248.160294352885, 5516.365617953987, 3796.297684928242, 3937.9606203938165, 3939.9015024624614, 3944.033711740642, 3947.3289540778137, 629.8866204083309, 633.0851918977035, 633.94294513494, 661.8279247395711, 669.1434963247052, 669.7454967112564, 675.42588799521, 687.7249100359896, 703.4407645921505, 775.2092865277385, 10275.588976441008, 10360.222983276133, 10407.479626018669, 10906.61826836057, 11107.611233606785, 659.5613916745407, 721.3183541553286, 757.7423675950093, 774.2605811450052, 776.2354081229984, 4477.440319960005, 4842.9757851211225, 4869.95130048695, 4879.780409881564, 4916.729579873141, 71663.64168179125, 107089.4645526783, 130745.0, 130928.0, 137528.0, 92784.53607731918, 113722.0, 117079.0, 117473.0, 119565.40217298857, 58790.11814822781, 80577.0, 84282.29629222714, 84415.57792211, 95876.9999999986, 10295.639652612123, 10816.134709223401, 10824.458777060958, 10826.729331766768, 10903.34579925207, 38885.0, 39071.218575628896, 53276.0, 54934.90130197453, 55411.72294138504, 25069.122580709587, 25244.116455923955, 51572.96854062973, 79655.20344796478, 81999.0, 13889.305534723426, 13933.651658708613, 13981.23103229332, 14079.859201407855, 14168.858311416754, 13907.304634768423, 14053.789193162314, 15108.54674359771, 15635.843641563439, 15889.602759931095, 11720.88279117198, 11866.940665296619, 11879.10906681985, 11979.04167666567, 12190.390480476119, 14374.928125359307, 14628.414863405345, 15189.43239960954, 15362.308696108925, 15694.686106278039, 14242.145471271757, 14281.42874285017, 14970.251487425803, 15684.451044213398, 15883.364665413254, 12165.817512737493, 12495.875041249472, 12709.682257943625, 12942.223466592035, 13157.0, 12272.263664180178, 12545.0, 12659.746805064031, 12808.0, 12832.280367147545], "value": 7952.254326898318, "unit": "score"}], "name": "dromaeo_css", "value": 7584.783263037519, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 109.0, 110.0, 111.0, 110.0, 109.0, 109.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 119.0, 158.0, 120.0, 117.0, 117.0, 116.0, 145.0, 118.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 159.0, 159.0, 158.0, 160.0, 162.0, 162.0, 158.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 109.0, 75.0, 77.0, 76.0, 76.0, 99.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 111.0, 80.0, 81.0, 80.0, 99.0, 81.0, 81.0, 111.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 147.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 51.0, 53.0, 50.0, 52.0, 55.0, 51.0, 51.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 74.0, 78.0, 78.0, 74.0, 73.0, 73.0, 74.0, 72.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 122.0, 123.0, 121.0, 124.0, 121.0, 122.0, 161.0, 129.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 157.0, 154.0, 155.0, 154.0, 155.0, 156.0, 153.0, 154.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 61.0, 61.0, 62.0, 61.0, 64.0, 61.0, 64.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1456.3999999999999, "alertThreshold": 2.0}]} 10:23:48 INFO - Return code: 0 10:23:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:23:48 INFO - # TBPL SUCCESS # 10:23:48 INFO - Running post-action listener: _resource_record_post_action 10:23:48 INFO - [mozharness: 2017-01-05 18:23:48.441374Z] Finished run-tests step (success) 10:23:48 INFO - Running post-run listener: _resource_record_post_run 10:23:48 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 7778304; Write bytes: 348405760; Read time: 1828; Write time: 311364 10:23:48 INFO - TinderboxPrint: CPU usage
12.9% 10:23:48 INFO - TinderboxPrint: I/O read bytes / time
7,778,304 / 1,828 10:23:48 INFO - TinderboxPrint: I/O write bytes / time
348,405,760 / 311,364 10:23:48 INFO - TinderboxPrint: CPU idle
8,273.0 (87.1%) 10:23:48 INFO - TinderboxPrint: CPU user
1,178.6 (12.4%) 10:23:48 INFO - TinderboxPrint: Swap in / out
0 / 0 10:23:48 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 3301376; Read time: 0; Write time: 9284 10:23:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5619712; Write bytes: 345104384; Read time: 1484; Write time: 302080 10:23:49 INFO - Running post-run listener: _upload_blobber_files 10:23:49 INFO - Blob upload gear active. 10:23:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:23:49 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 10:23:49 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'] 10:23:49 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 10:23:49 INFO - (blobuploader) - INFO - Open directory for files ... 10:23:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:23:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:50 INFO - (blobuploader) - INFO - Done attempting. 10:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:23:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:51 INFO - (blobuploader) - INFO - Done attempting. 10:23:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:23:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:23:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:54 INFO - (blobuploader) - INFO - Done attempting. 10:23:54 INFO - (blobuploader) - INFO - Iteration through files over. 10:23:54 INFO - Return code: 0 10:23:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:23:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:23:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3673fa749d5c252b8e571eec28ec638bc5b31f63a6d331a7caadaffe379067fc13a4f9fce633137b284cdbfacdd3dc699056d6d50f1586647d4b5e0455b28e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34f2684d0614f00592b6bd5e70a916702ff0154c15c20fef67e3b1762e7ec1717ae6a328f939f67c2ce0e7bc56de5ab70136a8a785eefac21129cf8a31084c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f383ca52dfd617d5561995de723d2feebfbfedb0336e02e23455753ecfff3cfdffcca74967a369d2c480903fb352f5624f2e6499ad73781a32cc180b013fec0"} 10:23:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:23:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:23:54 INFO - Contents: 10:23:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3673fa749d5c252b8e571eec28ec638bc5b31f63a6d331a7caadaffe379067fc13a4f9fce633137b284cdbfacdd3dc699056d6d50f1586647d4b5e0455b28e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34f2684d0614f00592b6bd5e70a916702ff0154c15c20fef67e3b1762e7ec1717ae6a328f939f67c2ce0e7bc56de5ab70136a8a785eefac21129cf8a31084c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f383ca52dfd617d5561995de723d2feebfbfedb0336e02e23455753ecfff3cfdffcca74967a369d2c480903fb352f5624f2e6499ad73781a32cc180b013fec0"} 10:23:54 INFO - Running post-run listener: copy_logs_to_upload_dir 10:23:54 INFO - Copying logs to upload dir... 10:23:54 INFO - mkdir: /builds/slave/test/build/upload/logs 10:23:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.342391 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-05 10:23:54.455117) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 10:23:54.458935) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982 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/3673fa749d5c252b8e571eec28ec638bc5b31f63a6d331a7caadaffe379067fc13a4f9fce633137b284cdbfacdd3dc699056d6d50f1586647d4b5e0455b28e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34f2684d0614f00592b6bd5e70a916702ff0154c15c20fef67e3b1762e7ec1717ae6a328f939f67c2ce0e7bc56de5ab70136a8a785eefac21129cf8a31084c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f383ca52dfd617d5561995de723d2feebfbfedb0336e02e23455753ecfff3cfdffcca74967a369d2c480903fb352f5624f2e6499ad73781a32cc180b013fec0"} build_url:https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011587 build_url: 'https://queue.taskcluster.net/v1/task/A6j6_xv9SVykqf71O35BqQ/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/3673fa749d5c252b8e571eec28ec638bc5b31f63a6d331a7caadaffe379067fc13a4f9fce633137b284cdbfacdd3dc699056d6d50f1586647d4b5e0455b28e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34f2684d0614f00592b6bd5e70a916702ff0154c15c20fef67e3b1762e7ec1717ae6a328f939f67c2ce0e7bc56de5ab70136a8a785eefac21129cf8a31084c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f383ca52dfd617d5561995de723d2feebfbfedb0336e02e23455753ecfff3cfdffcca74967a369d2c480903fb352f5624f2e6499ad73781a32cc180b013fec0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 10:23:54.484404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 10:23:54.484747) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1483639397.880491-993610982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 10:23:54.570816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 10:23:54.571150) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 10:23:54.571501) ========= ========= Total master_lag: 0.56 =========