builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1481517352.98 results: success (0) buildid: 20161211163002 builduid: a00252cb98aa460a8ebc90ff3a1c93ca revision: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:52.978215) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:52.978691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:52.979033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.001371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.001730) ========= 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=00204705a9daa57ed339a427000001b9-1481506119.331865-494705246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-11 20:35:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.4M=0s 2016-12-11 20:35:53 (69.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132314 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.148361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.148715) ========= 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=00204705a9daa57ed339a427000001b9-1481506119.331865-494705246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021872 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.209641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.210146) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 --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=00204705a9daa57ed339a427000001b9-1481506119.331865-494705246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-11 20:35:53,707 truncating revision to first 12 chars 2016-12-11 20:35:53,707 Setting DEBUG logging. 2016-12-11 20:35:53,707 attempt 1/10 2016-12-11 20:35:53,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42086c06f756?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-11 20:35:54,022 unpacking tar archive at: mozilla-central-42086c06f756/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631965 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.859371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.860131) ========= script_repo_revision: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.860984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.861310) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 20:35:53.874245) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-11 20:35:53.874603) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1481506119.331865-494705246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:35:54 INFO - MultiFileLogger online at 20161211 20:35:54 in /builds/slave/test 20:35:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:35:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:35:54 INFO - {'append_to_log': False, 20:35:54 INFO - 'base_work_dir': '/builds/slave/test', 20:35:54 INFO - 'blob_upload_branch': 'Firefox', 20:35:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:35:54 INFO - 'branch': 'Firefox', 20:35:54 INFO - 'buildbot_json_path': 'buildprops.json', 20:35:54 INFO - 'config_files': ('talos/linux_config.py',), 20:35:54 INFO - 'default_actions': ('clobber', 20:35:54 INFO - 'read-buildbot-config', 20:35:54 INFO - 'download-and-extract', 20:35:54 INFO - 'populate-webroot', 20:35:54 INFO - 'create-virtualenv', 20:35:54 INFO - 'install', 20:35:54 INFO - 'run-tests'), 20:35:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:35:54 INFO - 'download_minidump_stackwalk': True, 20:35:54 INFO - 'download_symbols': 'ondemand', 20:35:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:35:54 INFO - 'tooltool.py': '/tools/tooltool.py', 20:35:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:35:54 INFO - '/tools/misc-python/virtualenv.py')}, 20:35:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:35:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:35:54 INFO - 'installer_path': 'installer.exe', 20:35:54 INFO - 'log_level': 'info', 20:35:54 INFO - 'log_name': 'talos', 20:35:54 INFO - 'log_to_console': True, 20:35:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:35:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:35:54 INFO - 'opt_config_files': (), 20:35:54 INFO - 'pip_index': False, 20:35:54 INFO - 'sps_profile': False, 20:35:54 INFO - 'sps_profile_interval': 0, 20:35:54 INFO - 'suite': 'dromaeojs', 20:35:54 INFO - 'system_bits': '32', 20:35:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:35:54 INFO - 'title': 'talos-linux64-ix-016', 20:35:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:35:54 INFO - 'use_talos_json': True, 20:35:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:35:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:35:54 INFO - 'work_dir': 'build'} 20:35:54 INFO - [mozharness: 2016-12-12 04:35:54.468694Z] Running clobber step. 20:35:54 INFO - Running pre-action listener: _resource_record_pre_action 20:35:54 INFO - Running main action method: clobber 20:35:54 INFO - rmtree: /builds/slave/test/build 20:35:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:35:55 INFO - Running post-action listener: _resource_record_post_action 20:35:55 INFO - [mozharness: 2016-12-12 04:35:55.450353Z] Finished clobber step (success) 20:35:55 INFO - [mozharness: 2016-12-12 04:35:55.450452Z] Running read-buildbot-config step. 20:35:55 INFO - Running pre-action listener: _resource_record_pre_action 20:35:55 INFO - Running main action method: read_buildbot_config 20:35:55 INFO - Using buildbot properties: 20:35:55 INFO - { 20:35:55 INFO - "project": "", 20:35:55 INFO - "product": "firefox", 20:35:55 INFO - "script_repo_revision": "production", 20:35:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:35:55 INFO - "repository": "", 20:35:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 20:35:55 INFO - "buildid": "20161211163002", 20:35:55 INFO - "pgo_build": "True", 20:35:55 INFO - "basedir": "/builds/slave/test", 20:35:55 INFO - "buildnumber": 106, 20:35:55 INFO - "slavename": "talos-linux64-ix-016", 20:35:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:35:55 INFO - "platform": "ubuntu64_hw", 20:35:55 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 20:35:55 INFO - "branch": "mozilla-central", 20:35:55 INFO - "repo_path": "mozilla-central", 20:35:55 INFO - "revision": "42086c06f756cda7fbc25a2e7c20a5711f7e5f26", 20:35:55 INFO - "stage_platform": "linux64-pgo", 20:35:55 INFO - "builduid": "a00252cb98aa460a8ebc90ff3a1c93ca", 20:35:55 INFO - "slavebuilddir": "test" 20:35:55 INFO - } 20:35:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 20:35:55 INFO - Running post-action listener: _resource_record_post_action 20:35:55 INFO - [mozharness: 2016-12-12 04:35:55.452869Z] Finished read-buildbot-config step (success) 20:35:55 INFO - [mozharness: 2016-12-12 04:35:55.452957Z] Running download-and-extract step. 20:35:55 INFO - Running pre-action listener: _resource_record_pre_action 20:35:55 INFO - Running main action method: download_and_extract 20:35:55 INFO - mkdir: /builds/slave/test/build/tests 20:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:55 INFO - trying https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:35:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:35:56 INFO - Downloaded 1361 bytes. 20:35:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:35:56 INFO - Using the following test package requirements: 20:35:56 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:35:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:35:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:35:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:35:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:35:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:35:56 INFO - u'jsshell-linux-x86_64.zip'], 20:35:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:35:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:35:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:35:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:35:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:35:56 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:35:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:35:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:35:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:35:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:35:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:35:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:35:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:35:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:35:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:35:57 INFO - Expected file size: 21788495 20:35:57 INFO - Obtained file size: 21788495 20:36:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:36:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:36:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:36:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:36:03 INFO - Expected file size: 21788495 20:36:03 INFO - Obtained file size: 21788495 20:36:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 20:36:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:36:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:36:09 INFO - Expected file size: 14409734 20:36:09 INFO - Obtained file size: 14409734 20:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:09 INFO - trying https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:36:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:36:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:36:12 INFO - Downloaded 59960762 bytes. 20:36:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:36:12 INFO - mkdir: /builds/slave/test/properties 20:36:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:36:12 INFO - Writing to file /builds/slave/test/properties/build_url 20:36:12 INFO - Contents: 20:36:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:36:13 INFO - Running post-action listener: _resource_record_post_action 20:36:13 INFO - Running post-action listener: set_extra_try_arguments 20:36:13 INFO - [mozharness: 2016-12-12 04:36:13.362128Z] Finished download-and-extract step (success) 20:36:13 INFO - [mozharness: 2016-12-12 04:36:13.362356Z] Running populate-webroot step. 20:36:13 INFO - Running pre-action listener: _resource_record_pre_action 20:36:13 INFO - Running main action method: populate_webroot 20:36:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:36:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:36:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:36:13 INFO - '--tppagecycles', 20:36:13 INFO - '7'], 20:36:13 INFO - 'tests': ['tsvgm']}}, 20:36:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:36:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:36:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:36:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:36:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:36:13 INFO - 'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:36:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:36:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:36:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:36:13 INFO - 'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['damp', 'tps']}, 20:36:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:36:13 INFO - 'tests': ['damp', 'tps']}, 20:36:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['dromaeo_dom']}, 20:36:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:36:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['basic_compositor_video']}, 20:36:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:36:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['a11yr', 20:36:13 INFO - 'ts_paint', 20:36:13 INFO - 'tpaint', 20:36:13 INFO - 'sessionrestore', 20:36:13 INFO - 'sessionrestore_no_auto_restore', 20:36:13 INFO - 'tabpaint']}, 20:36:13 INFO - 'other-e10s': {'tests': ['a11yr', 20:36:13 INFO - 'ts_paint', 20:36:13 INFO - 'tpaint', 20:36:13 INFO - 'sessionrestore', 20:36:13 INFO - 'sessionrestore_no_auto_restore', 20:36:13 INFO - 'tabpaint']}, 20:36:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:36:13 INFO - 'ts_paint', 20:36:13 INFO - 'tpaint', 20:36:13 INFO - 'sessionrestore', 20:36:13 INFO - 'sessionrestore_no_auto_restore', 20:36:13 INFO - 'tabpaint']}, 20:36:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:36:13 INFO - 'ts_paint', 20:36:13 INFO - 'tpaint', 20:36:13 INFO - 'sessionrestore', 20:36:13 INFO - 'sessionrestore_no_auto_restore', 20:36:13 INFO - 'tabpaint']}, 20:36:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['a11yr', 20:36:13 INFO - 'ts_paint', 20:36:13 INFO - 'tpaint', 20:36:13 INFO - 'sessionrestore', 20:36:13 INFO - 'sessionrestore_no_auto_restore', 20:36:13 INFO - 'tabpaint']}, 20:36:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['a11yr', 20:36:13 INFO - 'ts_paint', 20:36:13 INFO - 'tpaint', 20:36:13 INFO - 'sessionrestore', 20:36:13 INFO - 'sessionrestore_no_auto_restore', 20:36:13 INFO - 'tabpaint']}, 20:36:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['tsvgx', 20:36:13 INFO - 'tsvgr_opacity', 20:36:13 INFO - 'tart', 20:36:13 INFO - 'tscrollx', 20:36:13 INFO - 'cart', 20:36:13 INFO - 'tsvg_static']}, 20:36:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:36:13 INFO - 'tsvgr_opacity', 20:36:13 INFO - 'tart', 20:36:13 INFO - 'tscrollx', 20:36:13 INFO - 'cart', 20:36:13 INFO - 'tsvg_static']}, 20:36:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:36:13 INFO - 'talos_options': ['--disable-e10s'], 20:36:13 INFO - 'tests': ['tp5o']}, 20:36:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:36:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:36:13 INFO - 'talos_options': ['--disable-e10s', 20:36:13 INFO - '--xperf_path', 20:36:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:36:13 INFO - 'tests': ['tp5n']}, 20:36:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:36:13 INFO - 'talos_options': ['--xperf_path', 20:36:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:36:13 INFO - 'tests': ['tp5n']}}, 20:36:13 INFO - 'talos.zip': {'path': '', 20:36:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:36:13 INFO - Running post-action listener: _resource_record_post_action 20:36:13 INFO - [mozharness: 2016-12-12 04:36:13.384101Z] Finished populate-webroot step (success) 20:36:13 INFO - [mozharness: 2016-12-12 04:36:13.384199Z] Running create-virtualenv step. 20:36:13 INFO - Running pre-action listener: _resource_record_pre_action 20:36:13 INFO - Running main action method: create_virtualenv 20:36:13 INFO - Creating virtualenv /builds/slave/test/build/venv 20:36:13 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 20:36:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:36:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:36:13 INFO - Using real prefix '/usr' 20:36:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:36:13 INFO - Installing distribute.............................................................................................................................................................................................done. 20:36:15 INFO - Installing pip.................done. 20:36:15 INFO - Return code: 0 20:36:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:36:16 INFO - Reading from file tmpfile_stdout 20:36:16 INFO - Output received: 20:36:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:36:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:36:16 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')]} 20:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:16 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')]} 20:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:16 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 0x7fcd7fbcbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, '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': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', '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 20:36:16 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 20:36:16 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 20:36:16 INFO - Using env: {'DISPLAY': ':0', 20:36:16 INFO - 'HOME': '/home/cltbld', 20:36:16 INFO - 'LANG': 'en_US.UTF-8', 20:36:16 INFO - 'LANGUAGE': 'en_US:en', 20:36:16 INFO - 'LOGNAME': 'cltbld', 20:36:16 INFO - 'MAIL': '/var/mail/cltbld', 20:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:16 INFO - 'MOZ_NO_REMOTE': '1', 20:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:16 INFO - 'NO_EM_RESTART': '1', 20:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:16 INFO - 'PWD': '/builds/slave/test', 20:36:16 INFO - 'SHELL': '/bin/bash', 20:36:16 INFO - 'SHLVL': '1', 20:36:16 INFO - 'TERM': 'linux', 20:36:16 INFO - 'TMOUT': '86400', 20:36:16 INFO - 'USER': 'cltbld', 20:36:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:16 INFO - '_': '/tools/buildbot/bin/python'} 20:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:16 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 20:36:16 INFO - Cleaning up... 20:36:16 INFO - Return code: 0 20:36:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:36:16 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')]} 20:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:16 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')]} 20:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:16 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 0x7fcd7fbcbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, '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': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', '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 20:36:16 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 20:36:16 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 20:36:16 INFO - Using env: {'DISPLAY': ':0', 20:36:16 INFO - 'HOME': '/home/cltbld', 20:36:16 INFO - 'LANG': 'en_US.UTF-8', 20:36:16 INFO - 'LANGUAGE': 'en_US:en', 20:36:16 INFO - 'LOGNAME': 'cltbld', 20:36:16 INFO - 'MAIL': '/var/mail/cltbld', 20:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:16 INFO - 'MOZ_NO_REMOTE': '1', 20:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:16 INFO - 'NO_EM_RESTART': '1', 20:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:16 INFO - 'PWD': '/builds/slave/test', 20:36:16 INFO - 'SHELL': '/bin/bash', 20:36:16 INFO - 'SHLVL': '1', 20:36:16 INFO - 'TERM': 'linux', 20:36:16 INFO - 'TMOUT': '86400', 20:36:16 INFO - 'USER': 'cltbld', 20:36:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:16 INFO - '_': '/tools/buildbot/bin/python'} 20:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:16 INFO - Downloading/unpacking psutil>=3.1.1 20:36:16 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 20:36:16 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 20:36:16 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 20:36:16 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 20:36:16 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 20:36:16 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 20:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:36:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:36:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:36:18 INFO - Installing collected packages: psutil 20:36:18 INFO - Running setup.py install for psutil 20:36:18 INFO - building 'psutil._psutil_linux' extension 20:36:18 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 20:36:19 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 20:36:19 INFO - building 'psutil._psutil_posix' extension 20:36:19 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 20:36:19 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 20:36:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:36:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:36:19 INFO - Successfully installed psutil 20:36:19 INFO - Cleaning up... 20:36:19 INFO - Return code: 0 20:36:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7fbcbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, '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': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', '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 20:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:36:19 INFO - Using env: {'DISPLAY': ':0', 20:36:19 INFO - 'HOME': '/home/cltbld', 20:36:19 INFO - 'LANG': 'en_US.UTF-8', 20:36:19 INFO - 'LANGUAGE': 'en_US:en', 20:36:19 INFO - 'LOGNAME': 'cltbld', 20:36:19 INFO - 'MAIL': '/var/mail/cltbld', 20:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:19 INFO - 'MOZ_NO_REMOTE': '1', 20:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:19 INFO - 'NO_EM_RESTART': '1', 20:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:19 INFO - 'PWD': '/builds/slave/test', 20:36:19 INFO - 'SHELL': '/bin/bash', 20:36:19 INFO - 'SHLVL': '1', 20:36:19 INFO - 'TERM': 'linux', 20:36:19 INFO - 'TMOUT': '86400', 20:36:19 INFO - 'USER': 'cltbld', 20:36:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:19 INFO - '_': '/tools/buildbot/bin/python'} 20:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:36:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:36:21 INFO - Installing collected packages: mozsystemmonitor 20:36:21 INFO - Running setup.py install for mozsystemmonitor 20:36:21 INFO - Successfully installed mozsystemmonitor 20:36:21 INFO - Cleaning up... 20:36:21 INFO - Return code: 0 20:36:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:36:21 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')]} 20:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:21 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')]} 20:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:21 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 0x7fcd7fbcbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, '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': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', '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 20:36:21 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 20:36:21 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 20:36:21 INFO - Using env: {'DISPLAY': ':0', 20:36:21 INFO - 'HOME': '/home/cltbld', 20:36:21 INFO - 'LANG': 'en_US.UTF-8', 20:36:21 INFO - 'LANGUAGE': 'en_US:en', 20:36:21 INFO - 'LOGNAME': 'cltbld', 20:36:21 INFO - 'MAIL': '/var/mail/cltbld', 20:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:21 INFO - 'MOZ_NO_REMOTE': '1', 20:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:21 INFO - 'NO_EM_RESTART': '1', 20:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:21 INFO - 'PWD': '/builds/slave/test', 20:36:21 INFO - 'SHELL': '/bin/bash', 20:36:21 INFO - 'SHLVL': '1', 20:36:21 INFO - 'TERM': 'linux', 20:36:21 INFO - 'TMOUT': '86400', 20:36:21 INFO - 'USER': 'cltbld', 20:36:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:21 INFO - '_': '/tools/buildbot/bin/python'} 20:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:21 INFO - Downloading/unpacking jsonschema==2.5.1 20:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:36:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:36:23 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 20:36:23 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 20:36:23 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 20:36:23 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 20:36:23 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 20:36:23 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 20:36:24 INFO - Downloading functools32-3.2.3-2.tar.gz 20:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:36:24 INFO - warning: no files found matching '*.txt' 20:36:24 INFO - no previously-included directories found matching 'build' 20:36:24 INFO - no previously-included directories found matching 'dist' 20:36:24 INFO - no previously-included directories found matching '.git*' 20:36:24 INFO - Installing collected packages: jsonschema, functools32 20:36:24 INFO - Running setup.py install for functools32 20:36:24 INFO - warning: no files found matching '*.txt' 20:36:24 INFO - no previously-included directories found matching 'build' 20:36:24 INFO - no previously-included directories found matching 'dist' 20:36:24 INFO - no previously-included directories found matching '.git*' 20:36:24 INFO - Successfully installed jsonschema functools32 20:36:24 INFO - Cleaning up... 20:36:24 INFO - Return code: 0 20:36:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd7fbcbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, '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': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', '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 20:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:36:24 INFO - Using env: {'DISPLAY': ':0', 20:36:24 INFO - 'HOME': '/home/cltbld', 20:36:24 INFO - 'LANG': 'en_US.UTF-8', 20:36:24 INFO - 'LANGUAGE': 'en_US:en', 20:36:24 INFO - 'LOGNAME': 'cltbld', 20:36:24 INFO - 'MAIL': '/var/mail/cltbld', 20:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:24 INFO - 'MOZ_NO_REMOTE': '1', 20:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:24 INFO - 'NO_EM_RESTART': '1', 20:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:24 INFO - 'PWD': '/builds/slave/test', 20:36:24 INFO - 'SHELL': '/bin/bash', 20:36:24 INFO - 'SHLVL': '1', 20:36:24 INFO - 'TERM': 'linux', 20:36:24 INFO - 'TMOUT': '86400', 20:36:24 INFO - 'USER': 'cltbld', 20:36:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:24 INFO - '_': '/tools/buildbot/bin/python'} 20:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:36:24 INFO - Cleaning up... 20:36:24 INFO - Return code: 0 20:36:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd7fbcbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, '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': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', '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 20:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:36:24 INFO - Using env: {'DISPLAY': ':0', 20:36:24 INFO - 'HOME': '/home/cltbld', 20:36:24 INFO - 'LANG': 'en_US.UTF-8', 20:36:24 INFO - 'LANGUAGE': 'en_US:en', 20:36:24 INFO - 'LOGNAME': 'cltbld', 20:36:24 INFO - 'MAIL': '/var/mail/cltbld', 20:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:24 INFO - 'MOZ_NO_REMOTE': '1', 20:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:24 INFO - 'NO_EM_RESTART': '1', 20:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:24 INFO - 'PWD': '/builds/slave/test', 20:36:24 INFO - 'SHELL': '/bin/bash', 20:36:24 INFO - 'SHLVL': '1', 20:36:24 INFO - 'TERM': 'linux', 20:36:24 INFO - 'TMOUT': '86400', 20:36:24 INFO - 'USER': 'cltbld', 20:36:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:24 INFO - '_': '/tools/buildbot/bin/python'} 20:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:24 INFO - Downloading/unpacking blobuploader==1.2.4 20:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:26 INFO - Downloading blobuploader-1.2.4.tar.gz 20:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:36:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:36:26 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 20:36:26 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 20:36:26 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 20:36:26 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 20:36:26 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 20:36:26 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 20:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:36:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:27 INFO - Downloading docopt-0.6.1.tar.gz 20:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:36:27 INFO - Installing collected packages: blobuploader, requests, docopt 20:36:27 INFO - Running setup.py install for blobuploader 20:36:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:36:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:36:27 INFO - Running setup.py install for requests 20:36:28 INFO - Running setup.py install for docopt 20:36:28 INFO - Successfully installed blobuploader requests docopt 20:36:28 INFO - Cleaning up... 20:36:28 INFO - Return code: 0 20:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:36:28 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')]} 20:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:28 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')]} 20:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:28 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 0x7fcd7fbcbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, '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': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', '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 20:36:28 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 20:36:28 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 20:36:28 INFO - Using env: {'DISPLAY': ':0', 20:36:28 INFO - 'HOME': '/home/cltbld', 20:36:28 INFO - 'LANG': 'en_US.UTF-8', 20:36:28 INFO - 'LANGUAGE': 'en_US:en', 20:36:28 INFO - 'LOGNAME': 'cltbld', 20:36:28 INFO - 'MAIL': '/var/mail/cltbld', 20:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:28 INFO - 'MOZ_NO_REMOTE': '1', 20:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:28 INFO - 'NO_EM_RESTART': '1', 20:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:28 INFO - 'PWD': '/builds/slave/test', 20:36:28 INFO - 'SHELL': '/bin/bash', 20:36:28 INFO - 'SHLVL': '1', 20:36:28 INFO - 'TERM': 'linux', 20:36:28 INFO - 'TMOUT': '86400', 20:36:28 INFO - 'USER': 'cltbld', 20:36:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:28 INFO - '_': '/tools/buildbot/bin/python'} 20:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:36:28 INFO - Running setup.py (path:/tmp/pip-QnnpSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:36:28 INFO - Running setup.py (path:/tmp/pip-0p_yZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:36:28 INFO - Running setup.py (path:/tmp/pip-cD21n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:36:28 INFO - Running setup.py (path:/tmp/pip-PEx2k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:36:28 INFO - Running setup.py (path:/tmp/pip-hMDrhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:36:28 INFO - Running setup.py (path:/tmp/pip-wmNUHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:36:28 INFO - Running setup.py (path:/tmp/pip-wU3vNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:36:28 INFO - Running setup.py (path:/tmp/pip-MsIEHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:36:28 INFO - Running setup.py (path:/tmp/pip-xZDZQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:36:29 INFO - Running setup.py (path:/tmp/pip-a_c75B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:36:29 INFO - Running setup.py (path:/tmp/pip-L_Dr4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:36:29 INFO - Running setup.py (path:/tmp/pip-awWueK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:36:29 INFO - Running setup.py (path:/tmp/pip-l8aKIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:36:29 INFO - Running setup.py (path:/tmp/pip-RcMfEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:29 INFO - Running setup.py (path:/tmp/pip-Pp_sm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:36:29 INFO - Running setup.py (path:/tmp/pip-p_eRDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:36:29 INFO - Running setup.py (path:/tmp/pip-W4Jx3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:36:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:36:29 INFO - Running setup.py install for manifestparser 20:36:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:36:29 INFO - Running setup.py install for mozcrash 20:36:29 INFO - Running setup.py install for mozdebug 20:36:29 INFO - Running setup.py install for mozdevice 20:36:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Running setup.py install for mozfile 20:36:30 INFO - Running setup.py install for mozhttpd 20:36:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Running setup.py install for mozinfo 20:36:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Running setup.py install for mozInstall 20:36:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Running setup.py install for mozleak 20:36:30 INFO - Running setup.py install for mozlog 20:36:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Running setup.py install for moznetwork 20:36:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Running setup.py install for mozprocess 20:36:30 INFO - Running setup.py install for mozprofile 20:36:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:36:30 INFO - Running setup.py install for mozrunner 20:36:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:36:31 INFO - Running setup.py install for mozscreenshot 20:36:31 INFO - Running setup.py install for moztest 20:36:31 INFO - Running setup.py install for mozversion 20:36:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:36:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:36:31 INFO - Cleaning up... 20:36:31 INFO - Return code: 0 20:36:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:36:31 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')]} 20:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:31 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')]} 20:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:31 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 0x7fcd7fbcbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, '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': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', '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 20:36:31 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 20:36:31 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 20:36:31 INFO - Using env: {'DISPLAY': ':0', 20:36:31 INFO - 'HOME': '/home/cltbld', 20:36:31 INFO - 'LANG': 'en_US.UTF-8', 20:36:31 INFO - 'LANGUAGE': 'en_US:en', 20:36:31 INFO - 'LOGNAME': 'cltbld', 20:36:31 INFO - 'MAIL': '/var/mail/cltbld', 20:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:31 INFO - 'MOZ_NO_REMOTE': '1', 20:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:31 INFO - 'NO_EM_RESTART': '1', 20:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:31 INFO - 'PWD': '/builds/slave/test', 20:36:31 INFO - 'SHELL': '/bin/bash', 20:36:31 INFO - 'SHLVL': '1', 20:36:31 INFO - 'TERM': 'linux', 20:36:31 INFO - 'TMOUT': '86400', 20:36:31 INFO - 'USER': 'cltbld', 20:36:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:31 INFO - '_': '/tools/buildbot/bin/python'} 20:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:36:31 INFO - Running setup.py (path:/tmp/pip-QA9VYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:36:31 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)) 20:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:36:31 INFO - Running setup.py (path:/tmp/pip-KHQHJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:36:31 INFO - Running setup.py (path:/tmp/pip-47MIkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:36:31 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)) 20:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:36:31 INFO - Running setup.py (path:/tmp/pip-CKxppp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:36:31 INFO - Running setup.py (path:/tmp/pip-IM3Akv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:36:32 INFO - Running setup.py (path:/tmp/pip-EytCf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:36:32 INFO - Running setup.py (path:/tmp/pip-Q_Xfz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:36:32 INFO - Running setup.py (path:/tmp/pip-LjVaDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:36:32 INFO - Running setup.py (path:/tmp/pip-mqcnVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:36:32 INFO - Running setup.py (path:/tmp/pip-1s_XsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:36:32 INFO - Running setup.py (path:/tmp/pip-gcx_Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:36:32 INFO - Running setup.py (path:/tmp/pip-0ZbrIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:36:32 INFO - Running setup.py (path:/tmp/pip-tDgOaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:36:32 INFO - Running setup.py (path:/tmp/pip-Soh8Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:32 INFO - Running setup.py (path:/tmp/pip-fnRdXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:36:32 INFO - Running setup.py (path:/tmp/pip-1R0SIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:36:32 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)) 20:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:36:32 INFO - Running setup.py (path:/tmp/pip-IWtDH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:36:32 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)) 20:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:36:32 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)) 20:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:36:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:34 INFO - Downloading blessings-1.6.tar.gz 20:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:36:34 INFO - Installing collected packages: blessings 20:36:34 INFO - Running setup.py install for blessings 20:36:35 INFO - Successfully installed blessings 20:36:35 INFO - Cleaning up... 20:36:35 INFO - Return code: 0 20:36:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:36:35 INFO - Reading from file tmpfile_stdout 20:36:35 INFO - Current package versions: 20:36:35 INFO - argparse == 1.2.1 20:36:35 INFO - blessings == 1.6 20:36:35 INFO - blobuploader == 1.2.4 20:36:35 INFO - docopt == 0.6.1 20:36:35 INFO - functools32 == 3.2.3-2 20:36:35 INFO - jsonschema == 2.5.1 20:36:35 INFO - manifestparser == 1.1 20:36:35 INFO - mozInstall == 1.12 20:36:35 INFO - mozcrash == 1.0 20:36:35 INFO - mozdebug == 0.1 20:36:35 INFO - mozdevice == 0.49 20:36:35 INFO - mozfile == 1.2 20:36:35 INFO - mozhttpd == 0.7 20:36:35 INFO - mozinfo == 0.9 20:36:35 INFO - mozleak == 0.1 20:36:35 INFO - mozlog == 3.4 20:36:35 INFO - moznetwork == 0.27 20:36:35 INFO - mozprocess == 0.23 20:36:35 INFO - mozprofile == 0.28 20:36:35 INFO - mozrunner == 6.13 20:36:35 INFO - mozscreenshot == 0.1 20:36:35 INFO - mozsystemmonitor == 0.3 20:36:35 INFO - moztest == 0.7 20:36:35 INFO - mozversion == 1.4 20:36:35 INFO - psutil == 3.1.1 20:36:35 INFO - requests == 1.2.3 20:36:35 INFO - wsgiref == 0.1.2 20:36:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:36:35 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')]} 20:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:35 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')]} 20:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:35 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 0x7fcd7fbcbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, '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': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', '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 20:36:35 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 20:36:35 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 20:36:35 INFO - Using env: {'DISPLAY': ':0', 20:36:35 INFO - 'HOME': '/home/cltbld', 20:36:35 INFO - 'LANG': 'en_US.UTF-8', 20:36:35 INFO - 'LANGUAGE': 'en_US:en', 20:36:35 INFO - 'LOGNAME': 'cltbld', 20:36:35 INFO - 'MAIL': '/var/mail/cltbld', 20:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:35 INFO - 'MOZ_NO_REMOTE': '1', 20:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:35 INFO - 'NO_EM_RESTART': '1', 20:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:35 INFO - 'PWD': '/builds/slave/test', 20:36:35 INFO - 'SHELL': '/bin/bash', 20:36:35 INFO - 'SHLVL': '1', 20:36:35 INFO - 'TERM': 'linux', 20:36:35 INFO - 'TMOUT': '86400', 20:36:35 INFO - 'USER': 'cltbld', 20:36:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:35 INFO - '_': '/tools/buildbot/bin/python'} 20:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:35 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)) 20:36:35 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)) 20:36:35 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)) 20:36:35 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)) 20:36:35 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)) 20:36:35 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)) 20:36:35 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)) 20:36:35 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)) 20:36:35 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)) 20:36:35 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)) 20:36:35 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)) 20:36:35 INFO - Cleaning up... 20:36:35 INFO - Return code: 0 20:36:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:36:35 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')]} 20:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:35 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')]} 20:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:35 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 0x7fcd7fbcbe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b95120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, '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': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', '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 20:36:35 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 20:36:35 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 20:36:35 INFO - Using env: {'DISPLAY': ':0', 20:36:35 INFO - 'HOME': '/home/cltbld', 20:36:35 INFO - 'LANG': 'en_US.UTF-8', 20:36:35 INFO - 'LANGUAGE': 'en_US:en', 20:36:35 INFO - 'LOGNAME': 'cltbld', 20:36:35 INFO - 'MAIL': '/var/mail/cltbld', 20:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:35 INFO - 'MOZ_NO_REMOTE': '1', 20:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:35 INFO - 'NO_EM_RESTART': '1', 20:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:35 INFO - 'PWD': '/builds/slave/test', 20:36:35 INFO - 'SHELL': '/bin/bash', 20:36:35 INFO - 'SHLVL': '1', 20:36:35 INFO - 'TERM': 'linux', 20:36:35 INFO - 'TMOUT': '86400', 20:36:35 INFO - 'USER': 'cltbld', 20:36:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:35 INFO - '_': '/tools/buildbot/bin/python'} 20:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:36:35 INFO - Cleaning up... 20:36:35 INFO - Return code: 0 20:36:35 INFO - Running post-action listener: _resource_record_post_action 20:36:35 INFO - Running post-action listener: _start_resource_monitoring 20:36:35 INFO - Starting resource monitoring. 20:36:35 INFO - [mozharness: 2016-12-12 04:36:35.860984Z] Finished create-virtualenv step (success) 20:36:35 INFO - [mozharness: 2016-12-12 04:36:35.861457Z] Running install step. 20:36:35 INFO - Running pre-action listener: _resource_record_pre_action 20:36:35 INFO - Running main action method: install 20:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:36:36 INFO - Reading from file tmpfile_stdout 20:36:36 INFO - Detecting whether we're running mozinstall >=1.0... 20:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:36:36 INFO - Reading from file tmpfile_stdout 20:36:36 INFO - Output received: 20:36:36 INFO - Usage: mozinstall [options] installer 20:36:36 INFO - Options: 20:36:36 INFO - -h, --help show this help message and exit 20:36:36 INFO - -d DEST, --destination=DEST 20:36:36 INFO - Directory to install application into. [default: 20:36:36 INFO - "/builds/slave/test"] 20:36:36 INFO - --app=APP Application being installed. [default: firefox] 20:36:36 INFO - mkdir: /builds/slave/test/build/application 20:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:36:53 INFO - Reading from file tmpfile_stdout 20:36:53 INFO - Output received: 20:36:53 INFO - /builds/slave/test/build/application/firefox/firefox 20:36:53 INFO - Running post-action listener: _resource_record_post_action 20:36:53 INFO - [mozharness: 2016-12-12 04:36:53.155366Z] Finished install step (success) 20:36:53 INFO - [mozharness: 2016-12-12 04:36:53.155609Z] Running run-tests step. 20:36:53 INFO - Running pre-action listener: _resource_record_pre_action 20:36:53 INFO - Running main action method: run_tests 20:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:36:53 INFO - Python 2.7.3 20:36:53 INFO - Return code: 0 20:36:53 INFO - grabbing minidump binary from tooltool 20:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:53 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 0x2c25f20>, '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 0x2b92c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b92f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:36:53 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 20:36:53 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 20:36:53 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 20:36:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:36:53 INFO - Return code: 0 20:36:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:36:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:36:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:36:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:36:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 20:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 20:36:53 INFO - Using env: {'DISPLAY': ':0', 20:36:53 INFO - 'HOME': '/home/cltbld', 20:36:53 INFO - 'LANG': 'en_US.UTF-8', 20:36:53 INFO - 'LANGUAGE': 'en_US:en', 20:36:53 INFO - 'LOGNAME': 'cltbld', 20:36:53 INFO - 'MAIL': '/var/mail/cltbld', 20:36:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:36:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:53 INFO - 'MOZ_NO_REMOTE': '1', 20:36:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:53 INFO - 'NO_EM_RESTART': '1', 20:36:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:53 INFO - 'PWD': '/builds/slave/test', 20:36:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:36:53 INFO - 'SHELL': '/bin/bash', 20:36:53 INFO - 'SHLVL': '1', 20:36:53 INFO - 'TERM': 'linux', 20:36:53 INFO - 'TMOUT': '86400', 20:36:53 INFO - 'USER': 'cltbld', 20:36:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1481506119.331865-494705246', 20:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:53 INFO - '_': '/tools/buildbot/bin/python'} 20:36:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 20:36:53 INFO - mozversion application_buildid: 20161211163002 20:36:53 INFO - mozversion application_changeset: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 20:36:53 INFO - mozversion application_display_name: Nightly 20:36:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:36:53 INFO - mozversion application_name: Firefox 20:36:53 INFO - mozversion application_remotingname: firefox 20:36:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:36:53 INFO - mozversion application_vendor: Mozilla 20:36:53 INFO - mozversion application_version: 53.0a1 20:36:53 INFO - mozversion platform_buildid: 20161211163002 20:36:53 INFO - mozversion platform_changeset: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 20:36:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:36:53 INFO - mozversion platform_version: 53.0a1 20:36:53 INFO - using testdate: 1481517413 20:36:53 INFO - actual date: 1481517413 20:36:53 INFO - starting webserver on 'localhost:53997' 20:36:53 INFO - SUITE-START | Running 2 tests 20:36:53 INFO - TEST-START | dromaeo_css 20:36:53 INFO - operating with platform_type : linux_ 20:36:53 INFO - Initialising browser for dromaeo_css test... 20:36:53 INFO - TEST-INFO | started process 25077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcnWrSk/profile http://localhost:53997/getInfo.html) 20:36:57 INFO - PROCESS | 25077 | __metrics Screen width/height:1600/1200 20:36:57 INFO - PROCESS | 25077 | colorDepth:24 20:36:57 INFO - PROCESS | 25077 | Browser inner width/height: 1024/697 20:36:57 INFO - PROCESS | 25077 | __metrics 20:36:58 INFO - PROCESS | 25077 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:36:58 INFO - PROCESS | 25077 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:36:58 INFO - PROCESS | 25077 | console.error: PushService: 20:36:58 INFO - PROCESS | 25077 | stateChangeProcessEnqueue: Error transitioning state 20:36:58 INFO - PROCESS | 25077 | UnknownError 20:36:59 INFO - TEST-INFO | 25077: exit 0 20:36:59 INFO - Browser initialized. 20:36:59 INFO - Running cycle 1/1 for dromaeo_css test... 20:36:59 INFO - TEST-INFO | started process 25163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcnWrSk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:37:11 INFO - PROCESS | 25163 | RSS: Main: 172503040 20:37:11 INFO - PROCESS | 25163 | 20:38:02 INFO - PROCESS | 25163 | 1481517482952 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] 20:40:12 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:53997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53997/tests/dromaeo/cssquery-ext.html) 20:40:15 INFO - PROCESS | 25163 | RSS: Main: 409018368 20:40:15 INFO - PROCESS | 25163 | 20:43:17 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:53997/tests/dromaeo/cssquery-ext.html (next: http://localhost:53997/tests/dromaeo/cssquery-jquery.html) 20:43:18 INFO - PROCESS | 25163 | RSS: Main: 286781440 20:43:18 INFO - PROCESS | 25163 | 20:46:20 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:53997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53997/tests/dromaeo/cssquery-mootools.html) 20:46:21 INFO - PROCESS | 25163 | RSS: Main: 227160064 20:46:21 INFO - PROCESS | 25163 | 20:49:23 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:53997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53997/tests/dromaeo/cssquery-prototype.html) 20:49:23 INFO - PROCESS | 25163 | RSS: Main: 254042112 20:49:23 INFO - PROCESS | 25163 | 20:52:26 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:53997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53997/tests/dromaeo/cssquery-yui.html) 20:52:27 INFO - PROCESS | 25163 | RSS: Main: 226861056 20:52:27 INFO - PROCESS | 25163 | 20:55:30 INFO - PROCESS | 25163 | Cycle 1(1): loaded http://localhost:53997/tests/dromaeo/cssquery-yui.html (next: http://localhost:53997/tests/dromaeo/cssquery-dojo.html) 20:55:30 INFO - PROCESS | 25163 | RSS: Main: 321998848 20:55:30 INFO - PROCESS | 25163 | 20:55:30 INFO - PROCESS | 25163 | __start_tp_report 20:55:30 INFO - PROCESS | 25163 | _x_x_mozilla_page_load 20:55:30 INFO - PROCESS | 25163 | _x_x_mozilla_page_load_details 20:55:30 INFO - PROCESS | 25163 | |i|pagename|runs| 20:55:30 INFO - PROCESS | 25163 | |0;dojo.html;3043.3913217356526;3082.306481041766;3092.7371173450256;3094.4275309067825;3128.953065704015;5145.511176438233;5200.609954253437;5250.028744682237;5268.973655131724;5327.627066105374;5261.86845328867;5269.683818970864;5320.813771517997;5345.893082138355;5390.757415916283;4684.812607495696;4702.482726900055;4713.858584242461;4748.5726284634375;4769.785359658824;4806.783694733728;4860.684055536379;4898.559129678329;4903.31353610493;4942.01159768046;4711.505291944365;4864.513548645143;4864.927026094611;4897.436794768611;4965.453800081988;4665.533446655341;4683.227267500858;4719.905601887977;4758.3576217210575;4767.570918617341;4838.612910967114;4842.055799119174;4843.200871856139;4873.31773551703;4881.926771098437;5357.383900851413;5388.299521062237;5390.6226564140525;5398.433164517708;5414.998225328327;5336.493033161843;5360.490753378423;5364.544013758835;5773.191753154561;5779;5446.2647542582035;5464.207689884945;5473.753681084321;5474.589405794582;5480.04099282624;5066.442691303953;5100.69395836251;5105.719185444799;5112.3865136183895;5121.8719532011255;5489.945100549024;5532.6680399176175;5535.197396377503;5536.335639723259;5536.778528858881;5337.985782701275;5342.626016178908;5342.866428339323;5343.198520221998;5345.251664766935;5523.558115350762;5574.303212098488;5584.497395234448;5587.8882422352135;5590.496855283044;5508.779648814003;5509.834704958857;5523.834284971457;5527.695976721238;5534.695591742493;5612.887742245132;5620.100783874561;5620.9437905621235;5621.915671264853;5669;4299.1831552005015;4337.306031035082;4344.391785150082;4390.363397307373;4396.1867054595;3825.980870095632;3840.6735427488416;3844.8654297099465;3874.6706529945272;3955.0903292242947;5249.895002099936;5293.100172970604;5308.442613525524;5317.787288508416;5340.919886201632;5611.579131565068;5621.7189140542805;5628.690422026746;5631.971840140773;5678.346990096109;5254;5268.236105764643;5269.71016594091;5301.814436494704;5323.840284791462;4778;4783.402074740658;4785.449673287617;4853.854384368475;4858.8785280367565;5781.971090144607;5821.301443826768;5852.385499522489;5852.531797456279;5905.940940590625;5572.609917305912;5623.803166889139;5625.043742563692;5626.85932851682;5640.689762062962;5846.649201047951;5898.4101589840675;5916.615419997686;5919.733611987384;5920.993431116634;5553;5594.1608758686525;5597.6641401516035;5599.692016939108;5602.495775380073;5684.687342196219;5714.942850571441;5718.885622287614;5723.027085395576;5723.284589426322;5582.162675598693;5591.524720398812;5593.804216852391;5596.328440586993;5596.720163991866;5554.472325129106;5582;5582.581306401955;5583.581231407579;5584.3857175711455;5362.7586758596735;5380.784768609212;5519.172124181405;5525.419830917695;5526.032944234823;5568.053430916673;5598.384177740364;5599.160125980972;5602.13166959122;5605.467480589337;5306.920396193983;5468.2891224142195;5475.753591088331;5482.342118945752;5532.944670553404 20:55:30 INFO - PROCESS | 25163 | |1;ext.html;547.7042397105563;573.23759399998;584.6492104737158;588.129568239006;591.911213318002;39691;41267.587324126784;41389.37915931259;44862.775686121604;45024.32463513042;43311.56688433115;43821.561784382146;43841;43965.34051989223;43971.56028439714;7799.49303295284;8664.436811607242;8853.867191992093;8858.689945851896;8872.11278872114;7765.339946104588;10089.293749437542;10357.896421035768;10366.326188797704;10638;10509.684709458728;10594.364338139698;10599.470026498682;10606.098481629071;10608.893911060906;10328.741781455448;10336.534855931426;10412.32319899204;10415.270931034831;10432.217583681178;10274.126699230574;10301.27891047627;10309.072183503446;10315.43265120418;10340.069393754524;39462;39787;39795.80102099471;39800.20399592021;39818;3129.687031296875;3129.9687003129907;3172.6510083890753;3238.4332741770095;3533.487644291589;30410.239744006576;30466.695333046606;30553.23616909573;30557.38885222305;30604.234894127603;4006.979965100156;4097.959020409788;4121.732087414309;4131.648809851166;4263.317869140954;318667;318712;319939;320346;321840.9999999977;56003.439965600635;56602.73589056474;56606.716966414904;56612.716936415876;56635.43364566384;60449.39550604438;60460.697696512114;60474;60558.69720651369;60571;14509.347079381454;14685.118892866461;14717.484888028868;14731.779023314659;14732.484363047242;10182.18542516597;10411.895881041244;10612.416317102634;11066.612668556561;11132.05377542918;17532.474025779247;17551.73672394915;17638.206280717397;17736.467905962843;17834.821651783317;6040.456358927718;6160.661163636043;6205.689715514206;6234.438900498977;6271.216097987752;825.9834803303901;861.5390765940192;970.9562220612869;973.5035132082688;1014.2545229256491;28531.57202641962;29865.656045478005;30088.699113008588;30139.09582712522;30654.693453065185;993.3046867192994;1141.2353723005606;1142.1034487926938;1146.0487795130023;1158.2645020412099;15518.456854010055;15648.921755391379;15816.60458488524;15830.60423489422;15981.440649577442;430508;437196;437477;438293;439216;56045.15932261019;56051.439485605435;56154;56178;56354;1138.7153211697075;1163.3310846263432;1233.0690328801518;1235.308227392645;1275.5344299330864;30182.69817301799;31281.687183127877;31565.52651710272;31811.6818831818;32279;47464;48027;48082.27876581924;48107.5189248117;48133;373684;377081;378876;379112;379551;24117.517649646557;24700.13549525758;24903.50192996166;25825;26010;40528.797356013034;40826.79586602048;40865.59134408618;41012.179756405305;41445.1710965785;34730.82634586811;35027.299454011285;35058.298834023684;35258.8237058813;35430.645693542734;34333;34443;34476;34696.479552806224;34839.30321393507;34483.31033379268;35209.295814084086;35522.467162993096;35754.821225893706;35991.82004089963;29250.561241580966;31971;32023.359532808747;32073;32109.678903210668;24158.39604009914;24684;24745.381365466008;24945.875270623532;25203.873980629978 20:55:30 INFO - PROCESS | 25163 | |2;jquery.html;329.5929527034114;342.7789076045949;350.48128769421254;355.23446971775826;362.9618890016548;13499.595012149626;17335.30658773649;17966.730499042525;18949.431517054476;19091.949942753145;18158.81841181588;18170;18293.908530457364;18392.81607183928;18585.349512767058;5199.038177937085;5372.677639341652;5391.353037635489;5391.973040134813;5403.189521571757;4003.099302656908;4067.491563554556;5261.579073674096;5353.330833645794;5360.490753378423;4185.874423767276;5906.438888305604;5986.521078313746;5988.940110598882;5989.3112292086535;5708.40061793514;5838.766449342063;5972.1638970543945;5975.462208401243;5978.312494063195;5134.127198376285;5145.948540514584;5149.819756308511;5174.068667639861;5176.430592634807;21570.35288941334;21863.453413664625;21994.670079948814;22045.669314960287;22140.446488837748;2085.4265077103764;2228.1755750372467;2383.8927248273694;2718.714534973819;2760.986195069012;13369.331533423387;13486.527971521047;13489.662758431019;13729.725405491934;14283.285835708173;1623.2127418202163;1655.4950740024287;1678.3873886031633;1680.269082948921;1753.1847690823702;55748;66318;70483.88941091114;70746.29253707448;73094;9217.585208665627;9239.630414783467;9326;9335.565606336935;9652.9034709652;12628.747425051632;12638.494460221673;12639.241645501299;12643.747125057631;12650.177738446971;6897.793066208022;6957.505058921589;7170.139583249939;7267.236940121211;7415;6967.338102880219;6997.650117494105;7029.648517574203;7144.714211431588;7184.024393291887;5854.5996141581745;5949.2266005419015;5972.313183983811;6012.699365031731;6178.6601736904;1567.3730507796972;1605.6226786705115;1643.7205675035273;1685.9831401686072;1695.5930576661513;365.12370311253204;840.878072679458;873.375536491399;993.5280741647804;1017.0033367300088;9840.852387214198;9905;9947.353422027545;10005.399676019462;10491.318064325947;387.61432374786705;400.57539008650923;400.86971734186506;406.3457832889105;407.6718241815367;5514.200440936042;5546.55627549795;5556.611037227436;5617.775288988477;5739.569532285095;387527;395105;411539;420926;448818;86256;86340.56829715811;87377.56311218403;87460;88340.5582972081;397.942298366741;409.0428397549748;409.6251929484548;409.6456565071192;410.6612045062835;9628.701378453132;9640.951795240979;9653.565589548627;9698.563564639468;9728.805423891341;30504.42433634884;33097.83451082729;35209.47185792164;36926.446103307935;38088.287486690715;53040.469595303555;53682.73158634182;54246.72876635592;54479.18281225864;55767;7083.256258092826;7239.348458638748;7448.143463501767;7495.43784216175;7720.53676779395;10449.268551201343;11401.885981140415;11531.192816502764;11812.645620631394;11859.881401185878;9999.650012249536;10183.643572475225;10256.58973641046;10262.640807571997;10282.845757313497;10235.539400727133;10482.737931551772;10498.947505262426;10499.107575856138;10580.735481613021;10675.57297708083;10682.83975740349;10822.40476773785;10947.34315941046;11097.778044438905;7178.497505174588;7321.3776828968;7410.740624078131;7437.851242975218;7450.217727138573;10019.448930308903;10235.641752538626;10252.64115755945;10362.585496580354;10986.725331866448 20:55:30 INFO - PROCESS | 25163 | |3;mootools.html;1224.920380175288;1340.4102195034186;1365.5766712319178;1455.4251070827017;1665.2423147467903;6686.632235227061;7664.501807382523;7806.882896756539;7833.999999999993;8100.432969692124;7950.840983180333;8021.3983951203745;8032.3975701822455;8033.758987230378;8033.839323213532;1723;1781.1450503758203;2055.537504061582;2127.1704035426196;2166.729158855143;2093.7696853346197;2119.3747844385866;2119.9152033918626;2123.8619489733196;2125.6492678708073;2060.0626714844784;2077.5013996640773;2079.4073688998637;2082.2607974169177;2117.6188286108495;1662.3267576631483;1714.9056801875893;2012.909419076145;2070.099506714584;2090.0908104974383;2078.553111081125;2102.02255950982;2104.989475052615;2105.1158513424243;2105.705201271823;7899.684012639487;7957.124716281204;7969.362451003905;7975.48159369645;7978.481398709124;4779.354787103731;4872;4905.411350637911;4908.656394052417;4912.582430493377;2923.6491621005403;3081.1372815611667;3155.9368812623848;3158.6683398243085;3159.699828516287;869.2828416556304;908.52756566585;918.6049998500642;938.8403971324891;942.0532364973227;10753.462326883624;10770.946145269223;10783.406912619803;10786.5685372585;10800.405977671226;4018.3972404139026;4160.812763425653;4250.851220207278;4266.573342665771;4342.109867477159;9370.390924590016;9371.531423428938;9372.39079459833;9373.625054997723;9373.62505499786;4807.663463557517;4811.879703007383;4848.878778030577;4851.975740121276;4870.732109733928;4215.515215750228;4455.821767129343;4460.665450091256;4462.1075784842515;4510.864674059718;3617.4754660574067;3704.0369503929173;3730.552333719971;3743.8502459901297;3756.868509602151;1197.7544603356291;1204.295487140033;1204.4883670993022;1211.2369207399458;1228.1280290993316;698.6855914838343;731.4587205467916;731.5967048246591;751.0574229342141;790.8141586727114;5003.199488081889;5196.1166601677805;5272.894542109137;5322.547583455373;5339.985402773538;371.98512059517316;372.2313422782001;373.7869414433801;378.13595933292845;383.530175534973;3443.862245510202;3480.2343484433386;3482.5995010574106;3542.6634469725336;3631.0377749896297;9467.431954082776;9751.3661611995;9877.901220987842;9886.4562449066;9892.25808064398;9767.267454940766;9767.951160244153;9770.609175633037;9783.706488805346;9821.950890245645;7025.964870175617;7324.425248571476;7472.738454154079;7583.393328533704;7602.087749470099;5426.131818908955;5437.755301011543;5473.261109750133;5487.341519017744;5634.605577609528;8760.255378292917;8781.165789250266;8872.201501864864;8952.28381729473;9014.098590140933;8984.281257499253;9096.909030909606;9139;9209.907900921173;9210.861837072584;6685;6853.965730171517;6898.586084834926;6904.171499420102;6912.688928998307;7489.28851759082;7608.31525162738;7608.8478230433975;7613.162552119152;7615.238476152341;6786.626735529593;6959.19969203548;7032.929670703432;7039.54242974205;7200.243974382614;6610.239822420291;6640.335966403514;6667.699953502201;6733.158355205599;6738.427233685192;5971.373005834324;6037.275526936795;6089.025755879038;6091.786787462417;6103.7253323601435;4451.465824101128;4536.6824322297125;4548.249538826057;4585.240103115413;4694.6009589185305;4641.721496710074;4654.697444666086;4657.441107067174;4717.858464246078;4774.30772537987 20:55:30 INFO - PROCESS | 25163 | |4;prototype.html;315.0909625729769;332.9800211987281;344.989181697626;346.53538244057114;351.9331327047861;4876.58549023333;5111.846644600659;5203.609729270305;5208.926733227395;5225;4959.603231741461;5096.286519887219;5123.180291153416;5129.1280482318;5138.511841375063;4022.939655905164;4032.354823228284;4034.5158580970324;4054.776987265707;4065.410515475254;3860.3244432224387;3908.355121404979;3950.1902110067513;4024.356103023517;4027.9597204028023;3974.105826189113;3981.5207891122486;3982.0642149095083;4009.6391324780766;4012.4783778108804;3966.4645272888224;3969.2458432897656;3994;3994.580569040267;4006.5392479864895;3260.2012506935716;3568.946465803015;3574.3208790329754;3575.12409459684;3586.5337506124038;4970.8508744737355;4986.287957879805;4991.450940396589;5008.273800298973;5036.798528058874;4445.488768791565;4484.551544845489;4496.9325460118125;4496.955030449719;4514.187446259672;5110.514501122388;5304.469553044703;5336.679799212021;5342.545883599899;5367;3746.644068813486;3757.8496860125833;3758.1732018955786;3766.5856755756845;3768.5289338832645;5471.288732464794;5490.243122200897;5503.889922201533;5520.923419933115;5529.944700552983;3774.735768496179;3780.905477363088;3781.6785573226584;3798.582155962842;3808.7143464240294;3711.2206436648066;3806.2577797329254;3810.142717888453;3823.4264860270628;3849.3263678856088;4250.362445633118;4296.720713153635;4370.366296886998;4418.226810308183;4425.402570652921;5324.7870085196155;5337.439568845293;5344.412114667383;5359.758810853521;5400.162974738922;1286.1832736212573;1300.8699130086916;1300.9267354432632;1302.1210682789078;1313.8817506424468;853.7748331144827;860.3461369359206;865.6539081727974;869.1308691308691;873.9082396348292;4930.482299358588;4952.603791696655;4953.752312384367;4985.833995412866;5020.4897551224385;5269.947300527022;5270.288511050959;5271.182966640177;5279.39286982002;5322.733863306819;4868.440129385095;4990.228468893563;4992.301077849104;4993.850184494471;5037.949620503821;2817.8309301441977;2839.2901774556362;2844.3458004659046;2848.962991461115;2859.2280084377103;5410.702411367334;5496.945030549723;5508.697021663847;5514.61397702157;5550.500454958992;5331.507862350167;5437.537809286255;5626.2685850839125;5637.46444087811;5672.517835983905;5696.695916368496;5707;5750.166225897222;5760.8271751847515;5764.117941029402;5354.78580856777;5462.9726851365485;5516.91724624139;5578.553715702653;5591.748371323381;5435.537979271806;5440.8639784004135;5449.373322068013;5461.15352120422;5486.765477767471;5676.373755389344;5696.259486266925;5709.771609135588;5740.512056475246;5759.8560035999435;3746.764226182473;3769.905752356103;3791.4123310886857;3804.2771873343977;3852.441395997621;5239.3234165066815;5502.862428439321;5517.944820551904;5524.392316845064;5540.7783688652;5245.868853278546;5287.788488460418;5357.464253574767;5382.658543533419;5403.729813509231;5339.492748188916;5340.145576707708;5355.089634762022;5366.973165134149;5380.192971054373;5207.791688332424;5250.632455728062;5276;5301.946980530145;5320;5343.4122246553625;5363.704996225245;5367.865803354947;5378.650387724785;5409.269748583891;5268.473152684701;5273.841784746463;5315.920261196163;5326.147816349366;5329.440408757025 20:55:30 INFO - PROCESS | 25163 | |5;yui.html;677.8305423644089;684.2234064336977;710.729922629401;742.9888551671729;751.1324420294558;13574.389152488136;14178.361973711182;14179.149251044944;14207.28963551821;14257.073290236127;14603.707925841476;14860.47988320409;14871.553853384416;14884.925575372108;14904.701905961874;653.7646447278976;671.4930227678096;762.8741257692474;769.2576663519702;788.4047544104193;778.3423007558604;791.6002418778509;791.6714563456187;791.6754130806371;792.2354927494966;834.4450940124809;835.2774849754949;838.8825564420955;839.5508403004394;840.5965136734371;681.1689738519024;695.8399568099366;796.5181065455374;830.6884918155691;830.9169083091703;604.5224272824463;608.4463138543904;608.6804427675462;609.1046162141645;609.5245708347496;14908.701825963528;15048.623784405478;15117.39530418782;15231.466898658493;15232.543023709306;12391.75216495665;12705.821340593866;12766.914812240972;13313.40089695966;13590.660233494242;11982.400879956054;12019.338936358497;12318.568850090294;12423.3788310585;13125.474981000749;4039.575844536311;4118.691098167649;4194.266003449384;4287.978560107211;4290.828366865321;76843;77361;80470;80915.5954220231;80997;9729.9027009729;10177.440240786827;10177.69466915979;10375.792484150275;10421.843672344921;18546.629067418846;19464;19573.314933977243;19910.402687919384;19957.700634490495;7648.235176482307;7717.1896950819355;7853;7910.5253684777945;8264.876026859602;4353.434053573015;4458.598726114666;4516.751578663139;4537.8184872604725;4584.701994370355;3154.6529881712995;3215.5498230247786;3224.7742658013713;3230.3216324572104;3252.219467327824;563.3465180390727;568.6815383385317;570.0736303506801;573.7080363946062;586.2642383808293;569.8432930944024;622.4522420270224;654.5385503220218;672.872937829144;676.577139287945;8622.78443038929;8981.416207946462;9005.774855628662;9012.63949442015;9059.909400906039;577.9855503612359;611.8868009418183;612.935641757618;627.1408170806025;671.1275342055309;4273.529911709709;4402.757848318373;4424.247877860771;4467.128909862546;4486.327050942319;83562.58218708867;83923;84185;84405.15594843973;85983.57008214919;60559.39440605626;62401.37598623956;66567.66716166388;72584.63707681428;75339.62330188314;64834;65463.34536654668;65512.01731974024;65884.67057664681;65899;7596.392288617008;7811;7887.802804929923;8018.158093400109;8144.5520496373265;43321;43458;44809.103817922805;44918.550814492744;45264;54812.451875480736;60271.698641508265;62037.37962620316;63389.36610633835;64198.67900660467;11400.543978240778;11416.771664566497;11666.650000499998;11712.121590880548;11837.112216583619;12468.875311246771;12478.43847026904;12516.12387132892;12733.172343797623;12980.610581682564;11018.283811552223;11412.372319522507;11622.593209237637;11627.825582616098;11889.762204756029;10852.782944341227;10895.400752958663;11071.280366776135;11124.332540047622;11413.517134219961;11235;11588.304701717923;11737.295762254293;11744.354060526754;12107.51569937228;8849.955750221208;9470.763230919281;9705.9029409705;9893.802123957625;10111.39331640104;9730.221582273543;9792.461414622265;9865.506724663881;9923.603055877973;9953.353032052893 20:55:30 INFO - PROCESS | 25163 | __end_tp_report 20:55:30 INFO - PROCESS | 25163 | __start_cc_report 20:55:30 INFO - PROCESS | 25163 | _x_x_mozilla_cycle_collect,2427 20:55:30 INFO - PROCESS | 25163 | __end_cc_report 20:55:30 INFO - PROCESS | 25163 | __startTimestamp1481518530357__endTimestamp 20:55:30 INFO - PROCESS | 25163 | 20:55:30 INFO - PROCESS | 25163 | ------- Summary: start ------- 20:55:30 INFO - PROCESS | 25163 | Number of tests: 6 20:55:30 INFO - PROCESS | 25163 | 20:55:30 INFO - PROCESS | 25163 | [#0] dojo.html Cycles:165 Average:5222.92 Median:5390.62 stddev:580.03 (10.8%) stddev-sans-first:556.03 20:55:30 INFO - PROCESS | 25163 | Values: 3043.4 3082.3 3092.7 3094.4 3129.0 5145.5 5200.6 5250.0 5269.0 5327.6 5261.9 5269.7 5320.8 5345.9 5390.8 4684.8 4702.5 4713.9 4748.6 4769.8 4806.8 4860.7 4898.6 4903.3 4942.0 4711.5 4864.5 4864.9 4897.4 4965.5 4665.5 4683.2 4719.9 4758.4 4767.6 4838.6 4842.1 4843.2 4873.3 4881.9 5357.4 5388.3 5390.6 5398.4 5415.0 5336.5 5360.5 5364.5 5773.2 5779.0 5446.3 5464.2 5473.8 5474.6 5480.0 5066.4 5100.7 5105.7 5112.4 5121.9 5489.9 5532.7 5535.2 5536.3 5536.8 5338.0 5342.6 5342.9 5343.2 5345.3 5523.6 5574.3 5584.5 5587.9 5590.5 5508.8 5509.8 5523.8 5527.7 5534.7 5612.9 5620.1 5620.9 5621.9 5669.0 4299.2 4337.3 4344.4 4390.4 4396.2 3826.0 3840.7 3844.9 3874.7 3955.1 5249.9 5293.1 5308.4 5317.8 5340.9 5611.6 5621.7 5628.7 5632.0 5678.3 5254.0 5268.2 5269.7 5301.8 5323.8 4778.0 4783.4 4785.4 4853.9 4858.9 5782.0 5821.3 5852.4 5852.5 5905.9 5572.6 5623.8 5625.0 5626.9 5640.7 5846.6 5898.4 5916.6 5919.7 5921.0 5553.0 5594.2 5597.7 5599.7 5602.5 5684.7 5714.9 5718.9 5723.0 5723.3 5582.2 5591.5 5593.8 5596.3 5596.7 5554.5 5582.0 5582.6 5583.6 5584.4 5362.8 5380.8 5519.2 5525.4 5526.0 5568.1 5598.4 5599.2 5602.1 5605.5 5306.9 5468.3 5475.8 5482.3 5532.9 20:55:30 INFO - PROCESS | 25163 | 20:55:30 INFO - PROCESS | 25163 | [#1] ext.html Cycles:180 Average:53505.24 Median:34479.66 stddev:100550.53 (291.6%) stddev-sans-first:100753.99 20:55:30 INFO - PROCESS | 25163 | Values: 547.7 573.2 584.6 588.1 591.9 39691.0 41267.6 41389.4 44862.8 45024.3 43311.6 43821.6 43841.0 43965.3 43971.6 7799.5 8664.4 8853.9 8858.7 8872.1 7765.3 10089.3 10357.9 10366.3 10638.0 10509.7 10594.4 10599.5 10606.1 10608.9 10328.7 10336.5 10412.3 10415.3 10432.2 10274.1 10301.3 10309.1 10315.4 10340.1 39462.0 39787.0 39795.8 39800.2 39818.0 3129.7 3130.0 3172.7 3238.4 3533.5 30410.2 30466.7 30553.2 30557.4 30604.2 4007.0 4098.0 4121.7 4131.6 4263.3 318667.0 318712.0 319939.0 320346.0 321841.0 56003.4 56602.7 56606.7 56612.7 56635.4 60449.4 60460.7 60474.0 60558.7 60571.0 14509.3 14685.1 14717.5 14731.8 14732.5 10182.2 10411.9 10612.4 11066.6 11132.1 17532.5 17551.7 17638.2 17736.5 17834.8 6040.5 6160.7 6205.7 6234.4 6271.2 826.0 861.5 971.0 973.5 1014.3 28531.6 29865.7 30088.7 30139.1 30654.7 993.3 1141.2 1142.1 1146.0 1158.3 15518.5 15648.9 15816.6 15830.6 15981.4 430508.0 437196.0 437477.0 438293.0 439216.0 56045.2 56051.4 56154.0 56178.0 56354.0 1138.7 1163.3 1233.1 1235.3 1275.5 30182.7 31281.7 31565.5 31811.7 32279.0 47464.0 48027.0 48082.3 48107.5 48133.0 373684.0 377081.0 378876.0 379112.0 379551.0 24117.5 24700.1 24903.5 25825.0 26010.0 40528.8 40826.8 40865.6 41012.2 41445.2 34730.8 35027.3 35058.3 35258.8 35430.6 34333.0 34443.0 34476.0 34696.5 34839.3 34483.3 35209.3 35522.5 35754.8 35991.8 29250.6 31971.0 32023.4 32073.0 32109.7 24158.4 24684.0 24745.4 24945.9 25203.9 20:55:30 INFO - PROCESS | 25163 | 20:55:30 INFO - PROCESS | 25163 | [#2] jquery.html Cycles:180 Average:24933.24 Median:410.15 stddev:68411.46 (16679.5%) stddev-sans-first:68578.42 20:55:30 INFO - PROCESS | 25163 | Values: 329.6 342.8 350.5 355.2 363.0 13499.6 17335.3 17966.7 18949.4 19091.9 18158.8 18170.0 18293.9 18392.8 18585.3 5199.0 5372.7 5391.4 5392.0 5403.2 4003.1 4067.5 5261.6 5353.3 5360.5 4185.9 5906.4 5986.5 5988.9 5989.3 5708.4 5838.8 5972.2 5975.5 5978.3 5134.1 5145.9 5149.8 5174.1 5176.4 21570.4 21863.5 21994.7 22045.7 22140.4 2085.4 2228.2 2383.9 2718.7 2761.0 13369.3 13486.5 13489.7 13729.7 14283.3 1623.2 1655.5 1678.4 1680.3 1753.2 55748.0 66318.0 70483.9 70746.3 73094.0 9217.6 9239.6 9326.0 9335.6 9652.9 12628.7 12638.5 12639.2 12643.7 12650.2 6897.8 6957.5 7170.1 7267.2 7415.0 6967.3 6997.7 7029.6 7144.7 7184.0 5854.6 5949.2 5972.3 6012.7 6178.7 1567.4 1605.6 1643.7 1686.0 1695.6 365.1 840.9 873.4 993.5 1017.0 9840.9 9905.0 9947.4 10005.4 10491.3 387.6 400.6 400.9 406.3 407.7 5514.2 5546.6 5556.6 5617.8 5739.6 387527.0 395105.0 411539.0 420926.0 448818.0 86256.0 86340.6 87377.6 87460.0 88340.6 397.9 409.0 409.6 409.6 410.7 9628.7 9641.0 9653.6 9698.6 9728.8 30504.4 33097.8 35209.5 36926.4 38088.3 53040.5 53682.7 54246.7 54479.2 55767.0 7083.3 7239.3 7448.1 7495.4 7720.5 10449.3 11401.9 11531.2 11812.6 11859.9 9999.7 10183.6 10256.6 10262.6 10282.8 10235.5 10482.7 10498.9 10499.1 10580.7 10675.6 10682.8 10822.4 10947.3 11097.8 7178.5 7321.4 7410.7 7437.9 7450.2 10019.4 10235.6 10252.6 10362.6 10986.7 20:55:30 INFO - PROCESS | 25163 | 20:55:30 INFO - PROCESS | 25163 | [#3] mootools.html Cycles:180 Average:5176.38 Median:5099.66 stddev:2964.74 (58.1%) stddev-sans-first:2958.18 20:55:30 INFO - PROCESS | 25163 | Values: 1224.9 1340.4 1365.6 1455.4 1665.2 6686.6 7664.5 7806.9 7834.0 8100.4 7950.8 8021.4 8032.4 8033.8 8033.8 1723.0 1781.1 2055.5 2127.2 2166.7 2093.8 2119.4 2119.9 2123.9 2125.6 2060.1 2077.5 2079.4 2082.3 2117.6 1662.3 1714.9 2012.9 2070.1 2090.1 2078.6 2102.0 2105.0 2105.1 2105.7 7899.7 7957.1 7969.4 7975.5 7978.5 4779.4 4872.0 4905.4 4908.7 4912.6 2923.6 3081.1 3155.9 3158.7 3159.7 869.3 908.5 918.6 938.8 942.1 10753.5 10770.9 10783.4 10786.6 10800.4 4018.4 4160.8 4250.9 4266.6 4342.1 9370.4 9371.5 9372.4 9373.6 9373.6 4807.7 4811.9 4848.9 4852.0 4870.7 4215.5 4455.8 4460.7 4462.1 4510.9 3617.5 3704.0 3730.6 3743.9 3756.9 1197.8 1204.3 1204.5 1211.2 1228.1 698.7 731.5 731.6 751.1 790.8 5003.2 5196.1 5272.9 5322.5 5340.0 372.0 372.2 373.8 378.1 383.5 3443.9 3480.2 3482.6 3542.7 3631.0 9467.4 9751.4 9877.9 9886.5 9892.3 9767.3 9768.0 9770.6 9783.7 9822.0 7026.0 7324.4 7472.7 7583.4 7602.1 5426.1 5437.8 5473.3 5487.3 5634.6 8760.3 8781.2 8872.2 8952.3 9014.1 8984.3 9096.9 9139.0 9209.9 9210.9 6685.0 6854.0 6898.6 6904.2 6912.7 7489.3 7608.3 7608.8 7613.2 7615.2 6786.6 6959.2 7032.9 7039.5 7200.2 6610.2 6640.3 6667.7 6733.2 6738.4 5971.4 6037.3 6089.0 6091.8 6103.7 4451.5 4536.7 4548.2 4585.2 4694.6 4641.7 4654.7 4657.4 4717.9 4774.3 20:55:30 INFO - PROCESS | 25163 | 20:55:30 INFO - PROCESS | 25163 | [#4] prototype.html Cycles:180 Average:4470.92 Median:5126.15 stddev:1331.23 (26.0%) stddev-sans-first:1297.91 20:55:30 INFO - PROCESS | 25163 | Values: 315.1 333.0 345.0 346.5 351.9 4876.6 5111.8 5203.6 5208.9 5225.0 4959.6 5096.3 5123.2 5129.1 5138.5 4022.9 4032.4 4034.5 4054.8 4065.4 3860.3 3908.4 3950.2 4024.4 4028.0 3974.1 3981.5 3982.1 4009.6 4012.5 3966.5 3969.2 3994.0 3994.6 4006.5 3260.2 3568.9 3574.3 3575.1 3586.5 4970.9 4986.3 4991.5 5008.3 5036.8 4445.5 4484.6 4496.9 4497.0 4514.2 5110.5 5304.5 5336.7 5342.5 5367.0 3746.6 3757.8 3758.2 3766.6 3768.5 5471.3 5490.2 5503.9 5520.9 5529.9 3774.7 3780.9 3781.7 3798.6 3808.7 3711.2 3806.3 3810.1 3823.4 3849.3 4250.4 4296.7 4370.4 4418.2 4425.4 5324.8 5337.4 5344.4 5359.8 5400.2 1286.2 1300.9 1300.9 1302.1 1313.9 853.8 860.3 865.7 869.1 873.9 4930.5 4952.6 4953.8 4985.8 5020.5 5269.9 5270.3 5271.2 5279.4 5322.7 4868.4 4990.2 4992.3 4993.9 5037.9 2817.8 2839.3 2844.3 2849.0 2859.2 5410.7 5496.9 5508.7 5514.6 5550.5 5331.5 5437.5 5626.3 5637.5 5672.5 5696.7 5707.0 5750.2 5760.8 5764.1 5354.8 5463.0 5516.9 5578.6 5591.7 5435.5 5440.9 5449.4 5461.2 5486.8 5676.4 5696.3 5709.8 5740.5 5759.9 3746.8 3769.9 3791.4 3804.3 3852.4 5239.3 5502.9 5517.9 5524.4 5540.8 5245.9 5287.8 5357.5 5382.7 5403.7 5339.5 5340.1 5355.1 5367.0 5380.2 5207.8 5250.6 5276.0 5301.9 5320.0 5343.4 5363.7 5367.9 5378.7 5409.3 5268.5 5273.8 5315.9 5326.1 5329.4 20:55:30 INFO - PROCESS | 25163 | 20:55:30 INFO - PROCESS | 25163 | [#5] yui.html Cycles:180 Average:17397.13 Median:575.85 stddev:23459.01 (4073.8%) stddev-sans-first:23491.23 20:55:30 INFO - PROCESS | 25163 | Values: 677.8 684.2 710.7 743.0 751.1 13574.4 14178.4 14179.1 14207.3 14257.1 14603.7 14860.5 14871.6 14884.9 14904.7 653.8 671.5 762.9 769.3 788.4 778.3 791.6 791.7 791.7 792.2 834.4 835.3 838.9 839.6 840.6 681.2 695.8 796.5 830.7 830.9 604.5 608.4 608.7 609.1 609.5 14908.7 15048.6 15117.4 15231.5 15232.5 12391.8 12705.8 12766.9 13313.4 13590.7 11982.4 12019.3 12318.6 12423.4 13125.5 4039.6 4118.7 4194.3 4288.0 4290.8 76843.0 77361.0 80470.0 80915.6 80997.0 9729.9 10177.4 10177.7 10375.8 10421.8 18546.6 19464.0 19573.3 19910.4 19957.7 7648.2 7717.2 7853.0 7910.5 8264.9 4353.4 4458.6 4516.8 4537.8 4584.7 3154.7 3215.5 3224.8 3230.3 3252.2 563.3 568.7 570.1 573.7 586.3 569.8 622.5 654.5 672.9 676.6 8622.8 8981.4 9005.8 9012.6 9059.9 578.0 611.9 612.9 627.1 671.1 4273.5 4402.8 4424.2 4467.1 4486.3 83562.6 83923.0 84185.0 84405.2 85983.6 60559.4 62401.4 66567.7 72584.6 75339.6 64834.0 65463.3 65512.0 65884.7 65899.0 7596.4 7811.0 7887.8 8018.2 8144.6 43321.0 43458.0 44809.1 44918.6 45264.0 54812.5 60271.7 62037.4 63389.4 64198.7 11400.5 11416.8 11666.7 11712.1 11837.1 12468.9 12478.4 12516.1 12733.2 12980.6 11018.3 11412.4 11622.6 11627.8 11889.8 10852.8 10895.4 11071.3 11124.3 11413.5 11235.0 11588.3 11737.3 11744.4 12107.5 8850.0 9470.8 9705.9 9893.8 10111.4 9730.2 9792.5 9865.5 9923.6 9953.4 20:55:30 INFO - PROCESS | 25163 | -------- Summary: end -------- 20:55:30 INFO - PROCESS | 25163 | 20:55:31 INFO - TEST-INFO | 25163: exit 0 20:55:31 INFO - TEST-OK | dromaeo_css | took 1117914ms 20:55:31 INFO - TEST-START | kraken 20:55:31 INFO - operating with platform_type : linux_ 20:55:31 INFO - Initialising browser for kraken test... 20:55:31 INFO - TEST-INFO | started process 25466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQN5r3q/profile http://localhost:53997/getInfo.html) 20:55:35 INFO - PROCESS | 25466 | __metrics Screen width/height:1600/1200 20:55:35 INFO - PROCESS | 25466 | colorDepth:24 20:55:35 INFO - PROCESS | 25466 | Browser inner width/height: 1024/697 20:55:35 INFO - PROCESS | 25466 | __metrics 20:55:35 INFO - PROCESS | 25466 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:55:35 INFO - PROCESS | 25466 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:55:36 INFO - PROCESS | 25466 | console.error: PushService: 20:55:36 INFO - PROCESS | 25466 | stateChangeProcessEnqueue: Error transitioning state 20:55:36 INFO - PROCESS | 25466 | UnknownError 20:55:37 INFO - TEST-INFO | 25466: exit 0 20:55:37 INFO - Browser initialized. 20:55:37 INFO - Running cycle 1/1 for kraken test... 20:55:37 INFO - TEST-INFO | started process 25554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQN5r3q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:55:49 INFO - PROCESS | 25554 | RSS: Main: 172388352 20:55:49 INFO - PROCESS | 25554 | 20:55:52 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53997/tests/kraken/driver.html?testName=audio-beat-detection) 20:55:52 INFO - PROCESS | 25554 | RSS: Main: 234586112 20:55:52 INFO - PROCESS | 25554 | 20:55:55 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53997/tests/kraken/driver.html?testName=audio-dft) 20:55:56 INFO - PROCESS | 25554 | RSS: Main: 216854528 20:55:56 INFO - PROCESS | 25554 | 20:55:59 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53997/tests/kraken/driver.html?testName=audio-fft) 20:55:59 INFO - PROCESS | 25554 | RSS: Main: 298991616 20:55:59 INFO - PROCESS | 25554 | 20:56:01 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53997/tests/kraken/driver.html?testName=audio-oscillator) 20:56:02 INFO - PROCESS | 25554 | RSS: Main: 210653184 20:56:02 INFO - PROCESS | 25554 | 20:56:04 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:56:05 INFO - PROCESS | 25554 | RSS: Main: 213602304 20:56:05 INFO - PROCESS | 25554 | 20:56:08 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53997/tests/kraken/driver.html?testName=imaging-darkroom) 20:56:08 INFO - PROCESS | 25554 | RSS: Main: 252968960 20:56:08 INFO - PROCESS | 25554 | 20:56:12 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53997/tests/kraken/driver.html?testName=imaging-desaturate) 20:56:12 INFO - PROCESS | 25554 | RSS: Main: 253231104 20:56:12 INFO - PROCESS | 25554 | 20:56:15 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53997/tests/kraken/driver.html?testName=json-parse-financial) 20:56:16 INFO - PROCESS | 25554 | RSS: Main: 251920384 20:56:16 INFO - PROCESS | 25554 | 20:56:17 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:56:18 INFO - PROCESS | 25554 | RSS: Main: 213884928 20:56:18 INFO - PROCESS | 25554 | 20:56:20 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53997/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:56:20 INFO - PROCESS | 25554 | RSS: Main: 220672000 20:56:20 INFO - PROCESS | 25554 | 20:56:22 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:56:23 INFO - PROCESS | 25554 | RSS: Main: 230039552 20:56:23 INFO - PROCESS | 25554 | 20:56:26 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:56:26 INFO - PROCESS | 25554 | RSS: Main: 238936064 20:56:26 INFO - PROCESS | 25554 | 20:56:29 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:56:30 INFO - PROCESS | 25554 | RSS: Main: 236584960 20:56:30 INFO - PROCESS | 25554 | 20:56:31 INFO - PROCESS | 25554 | Cycle 1(1): loaded http://localhost:53997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53997/tests/kraken/driver.html?testName=ai-astar) 20:56:32 INFO - PROCESS | 25554 | RSS: Main: 286724096 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | __start_tp_report 20:56:32 INFO - PROCESS | 25554 | _x_x_mozilla_page_load 20:56:32 INFO - PROCESS | 25554 | _x_x_mozilla_page_load_details 20:56:32 INFO - PROCESS | 25554 | |i|pagename|runs| 20:56:32 INFO - PROCESS | 25554 | |0;ai-astar;112;111;112;111;111;111;112;110;111;112 20:56:32 INFO - PROCESS | 25554 | |1;audio-beat-detection;144;129;131;178;131;135;124;130;148;125 20:56:32 INFO - PROCESS | 25554 | |2;audio-dft;163;161;161;160;160;161;161;163;163;164 20:56:32 INFO - PROCESS | 25554 | |3;audio-fft;74;75;76;105;76;75;76;75;102;75 20:56:32 INFO - PROCESS | 25554 | |4;audio-oscillator;93;83;104;83;84;83;96;83;83;112 20:56:32 INFO - PROCESS | 25554 | |5;imaging-gaussian-blur;126;127;126;127;127;127;127;127;126;127 20:56:32 INFO - PROCESS | 25554 | |6;imaging-darkroom;146;147;145;145;145;146;145;145;145;145 20:56:32 INFO - PROCESS | 25554 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;96 20:56:32 INFO - PROCESS | 25554 | |8;json-parse-financial;53;52;54;53;54;54;53;54;55;54 20:56:32 INFO - PROCESS | 25554 | |9;json-stringify-tinderbox;63;63;63;63;63;65;63;63;63;63 20:56:32 INFO - PROCESS | 25554 | |10;stanford-crypto-aes;82;89;83;82;87;81;80;81;81;80 20:56:32 INFO - PROCESS | 25554 | |11;stanford-crypto-ccm;143;131;129;127;131;132;147;135;186;160 20:56:32 INFO - PROCESS | 25554 | |12;stanford-crypto-pbkdf2;169;167;166;169;170;169;168;168;166;168 20:56:32 INFO - PROCESS | 25554 | |13;stanford-crypto-sha256-iterative;66;64;65;66;64;65;65;67;63;64 20:56:32 INFO - PROCESS | 25554 | __end_tp_report 20:56:32 INFO - PROCESS | 25554 | __start_cc_report 20:56:32 INFO - PROCESS | 25554 | _x_x_mozilla_cycle_collect,1685 20:56:32 INFO - PROCESS | 25554 | __end_cc_report 20:56:32 INFO - PROCESS | 25554 | __startTimestamp1481518592207__endTimestamp 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | ------- Summary: start ------- 20:56:32 INFO - PROCESS | 25554 | Number of tests: 14 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 20:56:32 INFO - PROCESS | 25554 | Values: 112.0 111.0 112.0 111.0 111.0 111.0 112.0 110.0 111.0 112.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:133.00 stddev:16.16 (12.2%) stddev-sans-first:16.97 20:56:32 INFO - PROCESS | 25554 | Values: 144.0 129.0 131.0 178.0 131.0 135.0 124.0 130.0 148.0 125.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.42 20:56:32 INFO - PROCESS | 25554 | Values: 163.0 161.0 161.0 160.0 160.0 161.0 161.0 163.0 163.0 164.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:11.95 (15.9%) stddev-sans-first:12.41 20:56:32 INFO - PROCESS | 25554 | Values: 74.0 75.0 76.0 105.0 76.0 75.0 76.0 75.0 102.0 75.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.00 stddev:10.56 (12.7%) stddev-sans-first:11.16 20:56:32 INFO - PROCESS | 25554 | Values: 93.0 83.0 104.0 83.0 84.0 83.0 96.0 83.0 83.0 112.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#5] imaging-gaussian-blur Cycles:10 Average:126.70 Median:127.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 20:56:32 INFO - PROCESS | 25554 | Values: 126.0 127.0 126.0 127.0 127.0 127.0 127.0 127.0 126.0 127.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 20:56:32 INFO - PROCESS | 25554 | Values: 146.0 147.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:56:32 INFO - PROCESS | 25554 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.84 (1.6%) stddev-sans-first:0.87 20:56:32 INFO - PROCESS | 25554 | Values: 53.0 52.0 54.0 53.0 54.0 54.0 53.0 54.0 55.0 54.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 20:56:32 INFO - PROCESS | 25554 | Values: 63.0 63.0 63.0 63.0 63.0 65.0 63.0 63.0 63.0 63.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:3.03 (3.7%) stddev-sans-first:3.20 20:56:32 INFO - PROCESS | 25554 | Values: 82.0 89.0 83.0 82.0 87.0 81.0 80.0 81.0 81.0 80.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:139.00 stddev:18.47 (13.3%) stddev-sans-first:19.59 20:56:32 INFO - PROCESS | 25554 | Values: 143.0 131.0 129.0 127.0 131.0 132.0 147.0 135.0 186.0 160.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.50 stddev:1.33 (0.8%) stddev-sans-first:1.36 20:56:32 INFO - PROCESS | 25554 | Values: 169.0 167.0 166.0 169.0 170.0 169.0 168.0 168.0 166.0 168.0 20:56:32 INFO - PROCESS | 25554 | 20:56:32 INFO - PROCESS | 25554 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 20:56:32 INFO - PROCESS | 25554 | Values: 66.0 64.0 65.0 66.0 64.0 65.0 65.0 67.0 63.0 64.0 20:56:32 INFO - PROCESS | 25554 | -------- Summary: end -------- 20:56:32 INFO - PROCESS | 25554 | 20:56:33 INFO - TEST-INFO | 25554: exit 0 20:56:33 INFO - TEST-OK | kraken | took 62108ms 20:56:33 INFO - SUITE-END | took 1180s 20:56:33 INFO - Completed test suite (00:19:40) 20:56:33 INFO - javascript benchmark 20:56:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.3913217356526, 3082.306481041766, 3092.7371173450256, 3094.4275309067825, 3128.953065704015, 5145.511176438233, 5200.609954253437, 5250.028744682237, 5268.973655131724, 5327.627066105374, 5261.86845328867, 5269.683818970864, 5320.813771517997, 5345.893082138355, 5390.757415916283, 4684.812607495696, 4702.482726900055, 4713.858584242461, 4748.5726284634375, 4769.785359658824, 4806.783694733728, 4860.684055536379, 4898.559129678329, 4903.31353610493, 4942.01159768046, 4711.505291944365, 4864.513548645143, 4864.927026094611, 4897.436794768611, 4965.453800081988, 4665.533446655341, 4683.227267500858, 4719.905601887977, 4758.3576217210575, 4767.570918617341, 4838.612910967114, 4842.055799119174, 4843.200871856139, 4873.31773551703, 4881.926771098437, 5357.383900851413, 5388.299521062237, 5390.6226564140525, 5398.433164517708, 5414.998225328327, 5336.493033161843, 5360.490753378423, 5364.544013758835, 5773.191753154561, 5779.0, 5446.2647542582035, 5464.207689884945, 5473.753681084321, 5474.589405794582, 5480.04099282624, 5066.442691303953, 5100.69395836251, 5105.719185444799, 5112.3865136183895, 5121.8719532011255, 5489.945100549024, 5532.6680399176175, 5535.197396377503, 5536.335639723259, 5536.778528858881, 5337.985782701275, 5342.626016178908, 5342.866428339323, 5343.198520221998, 5345.251664766935, 5523.558115350762, 5574.303212098488, 5584.497395234448, 5587.8882422352135, 5590.496855283044, 5508.779648814003, 5509.834704958857, 5523.834284971457, 5527.695976721238, 5534.695591742493, 5612.887742245132, 5620.100783874561, 5620.9437905621235, 5621.915671264853, 5669.0, 4299.1831552005015, 4337.306031035082, 4344.391785150082, 4390.363397307373, 4396.1867054595, 3825.980870095632, 3840.6735427488416, 3844.8654297099465, 3874.6706529945272, 3955.0903292242947, 5249.895002099936, 5293.100172970604, 5308.442613525524, 5317.787288508416, 5340.919886201632, 5611.579131565068, 5621.7189140542805, 5628.690422026746, 5631.971840140773, 5678.346990096109, 5254.0, 5268.236105764643, 5269.71016594091, 5301.814436494704, 5323.840284791462, 4778.0, 4783.402074740658, 4785.449673287617, 4853.854384368475, 4858.8785280367565, 5781.971090144607, 5821.301443826768, 5852.385499522489, 5852.531797456279, 5905.940940590625, 5572.609917305912, 5623.803166889139, 5625.043742563692, 5626.85932851682, 5640.689762062962, 5846.649201047951, 5898.4101589840675, 5916.615419997686, 5919.733611987384, 5920.993431116634, 5553.0, 5594.1608758686525, 5597.6641401516035, 5599.692016939108, 5602.495775380073, 5684.687342196219, 5714.942850571441, 5718.885622287614, 5723.027085395576, 5723.284589426322, 5582.162675598693, 5591.524720398812, 5593.804216852391, 5596.328440586993, 5596.720163991866, 5554.472325129106, 5582.0, 5582.581306401955, 5583.581231407579, 5584.3857175711455, 5362.7586758596735, 5380.784768609212, 5519.172124181405, 5525.419830917695, 5526.032944234823, 5568.053430916673, 5598.384177740364, 5599.160125980972, 5602.13166959122, 5605.467480589337, 5306.920396193983, 5468.2891224142195, 5475.753591088331, 5482.342118945752, 5532.944670553404], "value": 5184.867685809545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.7042397105563, 573.23759399998, 584.6492104737158, 588.129568239006, 591.911213318002, 39691.0, 41267.587324126784, 41389.37915931259, 44862.775686121604, 45024.32463513042, 43311.56688433115, 43821.561784382146, 43841.0, 43965.34051989223, 43971.56028439714, 7799.49303295284, 8664.436811607242, 8853.867191992093, 8858.689945851896, 8872.11278872114, 7765.339946104588, 10089.293749437542, 10357.896421035768, 10366.326188797704, 10638.0, 10509.684709458728, 10594.364338139698, 10599.470026498682, 10606.098481629071, 10608.893911060906, 10328.741781455448, 10336.534855931426, 10412.32319899204, 10415.270931034831, 10432.217583681178, 10274.126699230574, 10301.27891047627, 10309.072183503446, 10315.43265120418, 10340.069393754524, 39462.0, 39787.0, 39795.80102099471, 39800.20399592021, 39818.0, 3129.687031296875, 3129.9687003129907, 3172.6510083890753, 3238.4332741770095, 3533.487644291589, 30410.239744006576, 30466.695333046606, 30553.23616909573, 30557.38885222305, 30604.234894127603, 4006.979965100156, 4097.959020409788, 4121.732087414309, 4131.648809851166, 4263.317869140954, 318667.0, 318712.0, 319939.0, 320346.0, 321840.9999999977, 56003.439965600635, 56602.73589056474, 56606.716966414904, 56612.716936415876, 56635.43364566384, 60449.39550604438, 60460.697696512114, 60474.0, 60558.69720651369, 60571.0, 14509.347079381454, 14685.118892866461, 14717.484888028868, 14731.779023314659, 14732.484363047242, 10182.18542516597, 10411.895881041244, 10612.416317102634, 11066.612668556561, 11132.05377542918, 17532.474025779247, 17551.73672394915, 17638.206280717397, 17736.467905962843, 17834.821651783317, 6040.456358927718, 6160.661163636043, 6205.689715514206, 6234.438900498977, 6271.216097987752, 825.9834803303901, 861.5390765940192, 970.9562220612869, 973.5035132082688, 1014.2545229256491, 28531.57202641962, 29865.656045478005, 30088.699113008588, 30139.09582712522, 30654.693453065185, 993.3046867192994, 1141.2353723005606, 1142.1034487926938, 1146.0487795130023, 1158.2645020412099, 15518.456854010055, 15648.921755391379, 15816.60458488524, 15830.60423489422, 15981.440649577442, 430508.0, 437196.0, 437477.0, 438293.0, 439216.0, 56045.15932261019, 56051.439485605435, 56154.0, 56178.0, 56354.0, 1138.7153211697075, 1163.3310846263432, 1233.0690328801518, 1235.308227392645, 1275.5344299330864, 30182.69817301799, 31281.687183127877, 31565.52651710272, 31811.6818831818, 32279.0, 47464.0, 48027.0, 48082.27876581924, 48107.5189248117, 48133.0, 373684.0, 377081.0, 378876.0, 379112.0, 379551.0, 24117.517649646557, 24700.13549525758, 24903.50192996166, 25825.0, 26010.0, 40528.797356013034, 40826.79586602048, 40865.59134408618, 41012.179756405305, 41445.1710965785, 34730.82634586811, 35027.299454011285, 35058.298834023684, 35258.8237058813, 35430.645693542734, 34333.0, 34443.0, 34476.0, 34696.479552806224, 34839.30321393507, 34483.31033379268, 35209.295814084086, 35522.467162993096, 35754.821225893706, 35991.82004089963, 29250.561241580966, 31971.0, 32023.359532808747, 32073.0, 32109.678903210668, 24158.39604009914, 24684.0, 24745.381365466008, 24945.875270623532, 25203.873980629978], "value": 18895.12664645381, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.5929527034114, 342.7789076045949, 350.48128769421254, 355.23446971775826, 362.9618890016548, 13499.595012149626, 17335.30658773649, 17966.730499042525, 18949.431517054476, 19091.949942753145, 18158.81841181588, 18170.0, 18293.908530457364, 18392.81607183928, 18585.349512767058, 5199.038177937085, 5372.677639341652, 5391.353037635489, 5391.973040134813, 5403.189521571757, 4003.099302656908, 4067.491563554556, 5261.579073674096, 5353.330833645794, 5360.490753378423, 4185.874423767276, 5906.438888305604, 5986.521078313746, 5988.940110598882, 5989.3112292086535, 5708.40061793514, 5838.766449342063, 5972.1638970543945, 5975.462208401243, 5978.312494063195, 5134.127198376285, 5145.948540514584, 5149.819756308511, 5174.068667639861, 5176.430592634807, 21570.35288941334, 21863.453413664625, 21994.670079948814, 22045.669314960287, 22140.446488837748, 2085.4265077103764, 2228.1755750372467, 2383.8927248273694, 2718.714534973819, 2760.986195069012, 13369.331533423387, 13486.527971521047, 13489.662758431019, 13729.725405491934, 14283.285835708173, 1623.2127418202163, 1655.4950740024287, 1678.3873886031633, 1680.269082948921, 1753.1847690823702, 55748.0, 66318.0, 70483.88941091114, 70746.29253707448, 73094.0, 9217.585208665627, 9239.630414783467, 9326.0, 9335.565606336935, 9652.9034709652, 12628.747425051632, 12638.494460221673, 12639.241645501299, 12643.747125057631, 12650.177738446971, 6897.793066208022, 6957.505058921589, 7170.139583249939, 7267.236940121211, 7415.0, 6967.338102880219, 6997.650117494105, 7029.648517574203, 7144.714211431588, 7184.024393291887, 5854.5996141581745, 5949.2266005419015, 5972.313183983811, 6012.699365031731, 6178.6601736904, 1567.3730507796972, 1605.6226786705115, 1643.7205675035273, 1685.9831401686072, 1695.5930576661513, 365.12370311253204, 840.878072679458, 873.375536491399, 993.5280741647804, 1017.0033367300088, 9840.852387214198, 9905.0, 9947.353422027545, 10005.399676019462, 10491.318064325947, 387.61432374786705, 400.57539008650923, 400.86971734186506, 406.3457832889105, 407.6718241815367, 5514.200440936042, 5546.55627549795, 5556.611037227436, 5617.775288988477, 5739.569532285095, 387527.0, 395105.0, 411539.0, 420926.0, 448818.0, 86256.0, 86340.56829715811, 87377.56311218403, 87460.0, 88340.5582972081, 397.942298366741, 409.0428397549748, 409.6251929484548, 409.6456565071192, 410.6612045062835, 9628.701378453132, 9640.951795240979, 9653.565589548627, 9698.563564639468, 9728.805423891341, 30504.42433634884, 33097.83451082729, 35209.47185792164, 36926.446103307935, 38088.287486690715, 53040.469595303555, 53682.73158634182, 54246.72876635592, 54479.18281225864, 55767.0, 7083.256258092826, 7239.348458638748, 7448.143463501767, 7495.43784216175, 7720.53676779395, 10449.268551201343, 11401.885981140415, 11531.192816502764, 11812.645620631394, 11859.881401185878, 9999.650012249536, 10183.643572475225, 10256.58973641046, 10262.640807571997, 10282.845757313497, 10235.539400727133, 10482.737931551772, 10498.947505262426, 10499.107575856138, 10580.735481613021, 10675.57297708083, 10682.83975740349, 10822.40476773785, 10947.34315941046, 11097.778044438905, 7178.497505174588, 7321.3776828968, 7410.740624078131, 7437.851242975218, 7450.217727138573, 10019.448930308903, 10235.641752538626, 10252.64115755945, 10362.585496580354, 10986.725331866448], "value": 7712.53142936862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.920380175288, 1340.4102195034186, 1365.5766712319178, 1455.4251070827017, 1665.2423147467903, 6686.632235227061, 7664.501807382523, 7806.882896756539, 7833.999999999993, 8100.432969692124, 7950.840983180333, 8021.3983951203745, 8032.3975701822455, 8033.758987230378, 8033.839323213532, 1723.0, 1781.1450503758203, 2055.537504061582, 2127.1704035426196, 2166.729158855143, 2093.7696853346197, 2119.3747844385866, 2119.9152033918626, 2123.8619489733196, 2125.6492678708073, 2060.0626714844784, 2077.5013996640773, 2079.4073688998637, 2082.2607974169177, 2117.6188286108495, 1662.3267576631483, 1714.9056801875893, 2012.909419076145, 2070.099506714584, 2090.0908104974383, 2078.553111081125, 2102.02255950982, 2104.989475052615, 2105.1158513424243, 2105.705201271823, 7899.684012639487, 7957.124716281204, 7969.362451003905, 7975.48159369645, 7978.481398709124, 4779.354787103731, 4872.0, 4905.411350637911, 4908.656394052417, 4912.582430493377, 2923.6491621005403, 3081.1372815611667, 3155.9368812623848, 3158.6683398243085, 3159.699828516287, 869.2828416556304, 908.52756566585, 918.6049998500642, 938.8403971324891, 942.0532364973227, 10753.462326883624, 10770.946145269223, 10783.406912619803, 10786.5685372585, 10800.405977671226, 4018.3972404139026, 4160.812763425653, 4250.851220207278, 4266.573342665771, 4342.109867477159, 9370.390924590016, 9371.531423428938, 9372.39079459833, 9373.625054997723, 9373.62505499786, 4807.663463557517, 4811.879703007383, 4848.878778030577, 4851.975740121276, 4870.732109733928, 4215.515215750228, 4455.821767129343, 4460.665450091256, 4462.1075784842515, 4510.864674059718, 3617.4754660574067, 3704.0369503929173, 3730.552333719971, 3743.8502459901297, 3756.868509602151, 1197.7544603356291, 1204.295487140033, 1204.4883670993022, 1211.2369207399458, 1228.1280290993316, 698.6855914838343, 731.4587205467916, 731.5967048246591, 751.0574229342141, 790.8141586727114, 5003.199488081889, 5196.1166601677805, 5272.894542109137, 5322.547583455373, 5339.985402773538, 371.98512059517316, 372.2313422782001, 373.7869414433801, 378.13595933292845, 383.530175534973, 3443.862245510202, 3480.2343484433386, 3482.5995010574106, 3542.6634469725336, 3631.0377749896297, 9467.431954082776, 9751.3661611995, 9877.901220987842, 9886.4562449066, 9892.25808064398, 9767.267454940766, 9767.951160244153, 9770.609175633037, 9783.706488805346, 9821.950890245645, 7025.964870175617, 7324.425248571476, 7472.738454154079, 7583.393328533704, 7602.087749470099, 5426.131818908955, 5437.755301011543, 5473.261109750133, 5487.341519017744, 5634.605577609528, 8760.255378292917, 8781.165789250266, 8872.201501864864, 8952.28381729473, 9014.098590140933, 8984.281257499253, 9096.909030909606, 9139.0, 9209.907900921173, 9210.861837072584, 6685.0, 6853.965730171517, 6898.586084834926, 6904.171499420102, 6912.688928998307, 7489.28851759082, 7608.31525162738, 7608.8478230433975, 7613.162552119152, 7615.238476152341, 6786.626735529593, 6959.19969203548, 7032.929670703432, 7039.54242974205, 7200.243974382614, 6610.239822420291, 6640.335966403514, 6667.699953502201, 6733.158355205599, 6738.427233685192, 5971.373005834324, 6037.275526936795, 6089.025755879038, 6091.786787462417, 6103.7253323601435, 4451.465824101128, 4536.6824322297125, 4548.249538826057, 4585.240103115413, 4694.6009589185305, 4641.721496710074, 4654.697444666086, 4657.441107067174, 4717.858464246078, 4774.30772537987], "value": 4041.8193206518617, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.0909625729769, 332.9800211987281, 344.989181697626, 346.53538244057114, 351.9331327047861, 4876.58549023333, 5111.846644600659, 5203.609729270305, 5208.926733227395, 5225.0, 4959.603231741461, 5096.286519887219, 5123.180291153416, 5129.1280482318, 5138.511841375063, 4022.939655905164, 4032.354823228284, 4034.5158580970324, 4054.776987265707, 4065.410515475254, 3860.3244432224387, 3908.355121404979, 3950.1902110067513, 4024.356103023517, 4027.9597204028023, 3974.105826189113, 3981.5207891122486, 3982.0642149095083, 4009.6391324780766, 4012.4783778108804, 3966.4645272888224, 3969.2458432897656, 3994.0, 3994.580569040267, 4006.5392479864895, 3260.2012506935716, 3568.946465803015, 3574.3208790329754, 3575.12409459684, 3586.5337506124038, 4970.8508744737355, 4986.287957879805, 4991.450940396589, 5008.273800298973, 5036.798528058874, 4445.488768791565, 4484.551544845489, 4496.9325460118125, 4496.955030449719, 4514.187446259672, 5110.514501122388, 5304.469553044703, 5336.679799212021, 5342.545883599899, 5367.0, 3746.644068813486, 3757.8496860125833, 3758.1732018955786, 3766.5856755756845, 3768.5289338832645, 5471.288732464794, 5490.243122200897, 5503.889922201533, 5520.923419933115, 5529.944700552983, 3774.735768496179, 3780.905477363088, 3781.6785573226584, 3798.582155962842, 3808.7143464240294, 3711.2206436648066, 3806.2577797329254, 3810.142717888453, 3823.4264860270628, 3849.3263678856088, 4250.362445633118, 4296.720713153635, 4370.366296886998, 4418.226810308183, 4425.402570652921, 5324.7870085196155, 5337.439568845293, 5344.412114667383, 5359.758810853521, 5400.162974738922, 1286.1832736212573, 1300.8699130086916, 1300.9267354432632, 1302.1210682789078, 1313.8817506424468, 853.7748331144827, 860.3461369359206, 865.6539081727974, 869.1308691308691, 873.9082396348292, 4930.482299358588, 4952.603791696655, 4953.752312384367, 4985.833995412866, 5020.4897551224385, 5269.947300527022, 5270.288511050959, 5271.182966640177, 5279.39286982002, 5322.733863306819, 4868.440129385095, 4990.228468893563, 4992.301077849104, 4993.850184494471, 5037.949620503821, 2817.8309301441977, 2839.2901774556362, 2844.3458004659046, 2848.962991461115, 2859.2280084377103, 5410.702411367334, 5496.945030549723, 5508.697021663847, 5514.61397702157, 5550.500454958992, 5331.507862350167, 5437.537809286255, 5626.2685850839125, 5637.46444087811, 5672.517835983905, 5696.695916368496, 5707.0, 5750.166225897222, 5760.8271751847515, 5764.117941029402, 5354.78580856777, 5462.9726851365485, 5516.91724624139, 5578.553715702653, 5591.748371323381, 5435.537979271806, 5440.8639784004135, 5449.373322068013, 5461.15352120422, 5486.765477767471, 5676.373755389344, 5696.259486266925, 5709.771609135588, 5740.512056475246, 5759.8560035999435, 3746.764226182473, 3769.905752356103, 3791.4123310886857, 3804.2771873343977, 3852.441395997621, 5239.3234165066815, 5502.862428439321, 5517.944820551904, 5524.392316845064, 5540.7783688652, 5245.868853278546, 5287.788488460418, 5357.464253574767, 5382.658543533419, 5403.729813509231, 5339.492748188916, 5340.145576707708, 5355.089634762022, 5366.973165134149, 5380.192971054373, 5207.791688332424, 5250.632455728062, 5276.0, 5301.946980530145, 5320.0, 5343.4122246553625, 5363.704996225245, 5367.865803354947, 5378.650387724785, 5409.269748583891, 5268.473152684701, 5273.841784746463, 5315.920261196163, 5326.147816349366, 5329.440408757025], "value": 4047.9526992176375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.8305423644089, 684.2234064336977, 710.729922629401, 742.9888551671729, 751.1324420294558, 13574.389152488136, 14178.361973711182, 14179.149251044944, 14207.28963551821, 14257.073290236127, 14603.707925841476, 14860.47988320409, 14871.553853384416, 14884.925575372108, 14904.701905961874, 653.7646447278976, 671.4930227678096, 762.8741257692474, 769.2576663519702, 788.4047544104193, 778.3423007558604, 791.6002418778509, 791.6714563456187, 791.6754130806371, 792.2354927494966, 834.4450940124809, 835.2774849754949, 838.8825564420955, 839.5508403004394, 840.5965136734371, 681.1689738519024, 695.8399568099366, 796.5181065455374, 830.6884918155691, 830.9169083091703, 604.5224272824463, 608.4463138543904, 608.6804427675462, 609.1046162141645, 609.5245708347496, 14908.701825963528, 15048.623784405478, 15117.39530418782, 15231.466898658493, 15232.543023709306, 12391.75216495665, 12705.821340593866, 12766.914812240972, 13313.40089695966, 13590.660233494242, 11982.400879956054, 12019.338936358497, 12318.568850090294, 12423.3788310585, 13125.474981000749, 4039.575844536311, 4118.691098167649, 4194.266003449384, 4287.978560107211, 4290.828366865321, 76843.0, 77361.0, 80470.0, 80915.5954220231, 80997.0, 9729.9027009729, 10177.440240786827, 10177.69466915979, 10375.792484150275, 10421.843672344921, 18546.629067418846, 19464.0, 19573.314933977243, 19910.402687919384, 19957.700634490495, 7648.235176482307, 7717.1896950819355, 7853.0, 7910.5253684777945, 8264.876026859602, 4353.434053573015, 4458.598726114666, 4516.751578663139, 4537.8184872604725, 4584.701994370355, 3154.6529881712995, 3215.5498230247786, 3224.7742658013713, 3230.3216324572104, 3252.219467327824, 563.3465180390727, 568.6815383385317, 570.0736303506801, 573.7080363946062, 586.2642383808293, 569.8432930944024, 622.4522420270224, 654.5385503220218, 672.872937829144, 676.577139287945, 8622.78443038929, 8981.416207946462, 9005.774855628662, 9012.63949442015, 9059.909400906039, 577.9855503612359, 611.8868009418183, 612.935641757618, 627.1408170806025, 671.1275342055309, 4273.529911709709, 4402.757848318373, 4424.247877860771, 4467.128909862546, 4486.327050942319, 83562.58218708867, 83923.0, 84185.0, 84405.15594843973, 85983.57008214919, 60559.39440605626, 62401.37598623956, 66567.66716166388, 72584.63707681428, 75339.62330188314, 64834.0, 65463.34536654668, 65512.01731974024, 65884.67057664681, 65899.0, 7596.392288617008, 7811.0, 7887.802804929923, 8018.158093400109, 8144.5520496373265, 43321.0, 43458.0, 44809.103817922805, 44918.550814492744, 45264.0, 54812.451875480736, 60271.698641508265, 62037.37962620316, 63389.36610633835, 64198.67900660467, 11400.543978240778, 11416.771664566497, 11666.650000499998, 11712.121590880548, 11837.112216583619, 12468.875311246771, 12478.43847026904, 12516.12387132892, 12733.172343797623, 12980.610581682564, 11018.283811552223, 11412.372319522507, 11622.593209237637, 11627.825582616098, 11889.762204756029, 10852.782944341227, 10895.400752958663, 11071.280366776135, 11124.332540047622, 11413.517134219961, 11235.0, 11588.304701717923, 11737.295762254293, 11744.354060526754, 12107.51569937228, 8849.955750221208, 9470.763230919281, 9705.9029409705, 9893.802123957625, 10111.39331640104, 9730.221582273543, 9792.461414622265, 9865.506724663881, 9923.603055877973, 9953.353032052893], "value": 6793.7617802255645, "unit": "score"}], "name": "dromaeo_css", "value": 6617.731921626697, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 112.0, 111.0, 111.0, 111.0, 112.0, 110.0, 111.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 129.0, 131.0, 178.0, 131.0, 135.0, 124.0, 130.0, 148.0, 125.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 163.0, 163.0, 164.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 105.0, 76.0, 75.0, 76.0, 75.0, 102.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 83.0, 104.0, 83.0, 84.0, 83.0, 96.0, 83.0, 83.0, 112.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 126.0, 127.0, 127.0, 127.0, 127.0, 127.0, 126.0, 127.0], "value": 126.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.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": [53.0, 52.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0, 55.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 65.0, 63.0, 63.0, 63.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 89.0, 83.0, 82.0, 87.0, 81.0, 80.0, 81.0, 81.0, 80.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 131.0, 129.0, 127.0, 131.0, 132.0, 147.0, 135.0, 186.0, 160.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 166.0, 169.0, 170.0, 169.0, 168.0, 168.0, 166.0, 168.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 66.0, 64.0, 65.0, 65.0, 67.0, 63.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1523.5, "alertThreshold": 2.0}]} 20:56:33 INFO - Return code: 0 20:56:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:56:34 INFO - # TBPL SUCCESS # 20:56:34 INFO - Running post-action listener: _resource_record_post_action 20:56:34 INFO - [mozharness: 2016-12-12 04:56:34.010773Z] Finished run-tests step (success) 20:56:34 INFO - Running post-run listener: _resource_record_post_run 20:56:34 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392720384; Read time: 8; Write time: 242308 20:56:34 INFO - TinderboxPrint: CPU usage
13.1% 20:56:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:56:34 INFO - TinderboxPrint: I/O write bytes / time
392,720,384 / 242,308 20:56:34 INFO - TinderboxPrint: CPU idle
8,301.3 (86.8%) 20:56:34 INFO - TinderboxPrint: CPU user
1,207.0 (12.6%) 20:56:34 INFO - TinderboxPrint: Swap in / out
0 / 0 20:56:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103395328; Read time: 0; Write time: 64436 20:56:34 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288284672; Read time: 0; Write time: 177848 20:56:34 INFO - Running post-run listener: _upload_blobber_files 20:56:34 INFO - Blob upload gear active. 20:56:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:56:34 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 20:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:56:35 INFO - (blobuploader) - INFO - Open directory for files ... 20:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:56:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:56:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:56:35 INFO - (blobuploader) - INFO - Done attempting. 20:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:56:39 INFO - (blobuploader) - INFO - Done attempting. 20:56:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:56:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:56:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:56:39 INFO - (blobuploader) - INFO - Done attempting. 20:56:39 INFO - (blobuploader) - INFO - Iteration through files over. 20:56:39 INFO - Return code: 0 20:56:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:56:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:56:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/841e754d34b26e07ff9fe4b665d2704640c0e1b9733925aa287d4e21d4ecacc3538aa85e7dc010c1f84eadb850c051ec1447f60bce2a4799bf1ebd225751bbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e43deed734269de4d5d6d0bd809a4c816669d834225526777bca7fe76ebd7e72fefe7e2dd96f4122b7a2ec477a33a272c5ad9c1dd2bc9c5ed3e09e897d0bfcba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f49cb69589bcdc4fa424270b84bdd55813ef2b7e7b6933a48c74eac2d26d1b5eb1203cdcbe7fa466c9f1e2f56a667c84659a9580d1eaa09d707a30b6dde72eda"} 20:56:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:56:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:56:39 INFO - Contents: 20:56:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/841e754d34b26e07ff9fe4b665d2704640c0e1b9733925aa287d4e21d4ecacc3538aa85e7dc010c1f84eadb850c051ec1447f60bce2a4799bf1ebd225751bbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e43deed734269de4d5d6d0bd809a4c816669d834225526777bca7fe76ebd7e72fefe7e2dd96f4122b7a2ec477a33a272c5ad9c1dd2bc9c5ed3e09e897d0bfcba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f49cb69589bcdc4fa424270b84bdd55813ef2b7e7b6933a48c74eac2d26d1b5eb1203cdcbe7fa466c9f1e2f56a667c84659a9580d1eaa09d707a30b6dde72eda"} 20:56:39 INFO - Running post-run listener: copy_logs_to_upload_dir 20:56:39 INFO - Copying logs to upload dir... 20:56:39 INFO - mkdir: /builds/slave/test/build/upload/logs 20:56:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.627345 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-11 20:56:39.601978) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 20:56:39.609961) ========= 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=00204705a9daa57ed339a427000001b9-1481506119.331865-494705246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/841e754d34b26e07ff9fe4b665d2704640c0e1b9733925aa287d4e21d4ecacc3538aa85e7dc010c1f84eadb850c051ec1447f60bce2a4799bf1ebd225751bbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e43deed734269de4d5d6d0bd809a4c816669d834225526777bca7fe76ebd7e72fefe7e2dd96f4122b7a2ec477a33a272c5ad9c1dd2bc9c5ed3e09e897d0bfcba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f49cb69589bcdc4fa424270b84bdd55813ef2b7e7b6933a48c74eac2d26d1b5eb1203cdcbe7fa466c9f1e2f56a667c84659a9580d1eaa09d707a30b6dde72eda"} build_url:https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011814 build_url: 'https://queue.taskcluster.net/v1/task/Kwve72xrRcWS9Y5qkuZAhQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/841e754d34b26e07ff9fe4b665d2704640c0e1b9733925aa287d4e21d4ecacc3538aa85e7dc010c1f84eadb850c051ec1447f60bce2a4799bf1ebd225751bbf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e43deed734269de4d5d6d0bd809a4c816669d834225526777bca7fe76ebd7e72fefe7e2dd96f4122b7a2ec477a33a272c5ad9c1dd2bc9c5ed3e09e897d0bfcba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f49cb69589bcdc4fa424270b84bdd55813ef2b7e7b6933a48c74eac2d26d1b5eb1203cdcbe7fa466c9f1e2f56a667c84659a9580d1eaa09d707a30b6dde72eda"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 20:56:39.638428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 20:56:39.638769) ========= 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=00204705a9daa57ed339a427000001b9-1481506119.331865-494705246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 20:56:39.688300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 20:56:39.690846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 20:56:39.691215) ========= ========= Total master_lag: 0.23 =========