builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1481892412.93 results: success (0) buildid: 20161216030207 builduid: bd9d08466d6d4eb5a1a69581aff118b0 revision: 63b447888a6469b9f6ae8f76ac5f0d7c6ea239da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:52.934861) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:52.935222) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:52.935499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:52.952054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:52.952309) ========= 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=cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-16 04:46:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.8M=0s 2016-12-16 04:46:53 (43.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:53.100199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:53.100470) ========= 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=cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015954 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:53.152670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:53.152976) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 63b447888a6469b9f6ae8f76ac5f0d7c6ea239da --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 63b447888a6469b9f6ae8f76ac5f0d7c6ea239da --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=cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-16 04:46:53,653 truncating revision to first 12 chars 2016-12-16 04:46:53,653 Setting DEBUG logging. 2016-12-16 04:46:53,653 attempt 1/10 2016-12-16 04:46:53,653 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/63b447888a64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-16 04:46:53,955 unpacking tar archive at: mozilla-central-63b447888a64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631111 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:53.797019) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:53.797324) ========= script_repo_revision: 63b447888a6469b9f6ae8f76ac5f0d7c6ea239da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:53.797713) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:53.797998) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 04:46:53.811398) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-12-16 04:46:53.811731) ========= /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=cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:46:54 INFO - MultiFileLogger online at 20161216 04:46:54 in /builds/slave/test 04:46:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:46:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:54 INFO - {'append_to_log': False, 04:46:54 INFO - 'base_work_dir': '/builds/slave/test', 04:46:54 INFO - 'blob_upload_branch': 'Firefox', 04:46:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:54 INFO - 'branch': 'Firefox', 04:46:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:54 INFO - 'config_files': ('talos/linux_config.py',), 04:46:54 INFO - 'default_actions': ('clobber', 04:46:54 INFO - 'read-buildbot-config', 04:46:54 INFO - 'download-and-extract', 04:46:54 INFO - 'populate-webroot', 04:46:54 INFO - 'create-virtualenv', 04:46:54 INFO - 'install', 04:46:54 INFO - 'run-tests'), 04:46:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:54 INFO - 'download_minidump_stackwalk': True, 04:46:54 INFO - 'download_symbols': 'ondemand', 04:46:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:54 INFO - 'installer_path': 'installer.exe', 04:46:54 INFO - 'log_level': 'info', 04:46:54 INFO - 'log_name': 'talos', 04:46:54 INFO - 'log_to_console': True, 04:46:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:46:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:46:54 INFO - 'opt_config_files': (), 04:46:54 INFO - 'pip_index': False, 04:46:54 INFO - 'sps_profile': False, 04:46:54 INFO - 'sps_profile_interval': 0, 04:46:54 INFO - 'suite': 'dromaeojs', 04:46:54 INFO - 'system_bits': '32', 04:46:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:54 INFO - 'title': 'talos-linux64-ix-054', 04:46:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:54 INFO - 'use_talos_json': True, 04:46:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:54 INFO - 'work_dir': 'build'} 04:46:54 INFO - [mozharness: 2016-12-16 12:46:54.411733Z] Running clobber step. 04:46:54 INFO - Running pre-action listener: _resource_record_pre_action 04:46:54 INFO - Running main action method: clobber 04:46:54 INFO - rmtree: /builds/slave/test/build 04:46:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:55 INFO - Running post-action listener: _resource_record_post_action 04:46:55 INFO - [mozharness: 2016-12-16 12:46:55.382610Z] Finished clobber step (success) 04:46:55 INFO - [mozharness: 2016-12-16 12:46:55.382708Z] Running read-buildbot-config step. 04:46:55 INFO - Running pre-action listener: _resource_record_pre_action 04:46:55 INFO - Running main action method: read_buildbot_config 04:46:55 INFO - Using buildbot properties: 04:46:55 INFO - { 04:46:55 INFO - "project": "", 04:46:55 INFO - "product": "firefox", 04:46:55 INFO - "script_repo_revision": "production", 04:46:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:46:55 INFO - "repository": "", 04:46:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:46:55 INFO - "buildid": "20161216030207", 04:46:55 INFO - "stage_platform": "linux64-pgo", 04:46:55 INFO - "basedir": "/builds/slave/test", 04:46:55 INFO - "nightly_build": "True", 04:46:55 INFO - "buildnumber": 116, 04:46:55 INFO - "slavename": "talos-linux64-ix-054", 04:46:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:46:55 INFO - "platform": "ubuntu64_hw", 04:46:55 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:46:55 INFO - "branch": "mozilla-central", 04:46:55 INFO - "repo_path": "mozilla-central", 04:46:55 INFO - "revision": "63b447888a6469b9f6ae8f76ac5f0d7c6ea239da", 04:46:55 INFO - "pgo_build": "True", 04:46:55 INFO - "builduid": "bd9d08466d6d4eb5a1a69581aff118b0", 04:46:55 INFO - "slavebuilddir": "test" 04:46:55 INFO - } 04:46:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 04:46:55 INFO - Running post-action listener: _resource_record_post_action 04:46:55 INFO - [mozharness: 2016-12-16 12:46:55.385193Z] Finished read-buildbot-config step (success) 04:46:55 INFO - [mozharness: 2016-12-16 12:46:55.385281Z] Running download-and-extract step. 04:46:55 INFO - Running pre-action listener: _resource_record_pre_action 04:46:55 INFO - Running main action method: download_and_extract 04:46:55 INFO - mkdir: /builds/slave/test/build/tests 04:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:55 INFO - trying https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:46:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:46:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:46:55 INFO - Downloaded 1361 bytes. 04:46:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:46:55 INFO - Using the following test package requirements: 04:46:55 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:55 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:46:55 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:46:55 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:55 INFO - u'jsshell-linux-x86_64.zip'], 04:46:55 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:46:55 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:55 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:46:55 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:46:55 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:46:55 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:46:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:46:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:46:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:46:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:46:57 INFO - Expected file size: 21776472 04:46:57 INFO - Obtained file size: 21776472 04:47:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:47:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:47:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:47:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:47:02 INFO - Expected file size: 21776472 04:47:02 INFO - Obtained file size: 21776472 04:47:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 04:47:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:47:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:47:08 INFO - Expected file size: 14409734 04:47:08 INFO - Obtained file size: 14409734 04:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:08 INFO - trying https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:47:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:47:10 INFO - Downloaded 59830944 bytes. 04:47:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:47:10 INFO - mkdir: /builds/slave/test/properties 04:47:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:10 INFO - Contents: 04:47:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:47:11 INFO - Running post-action listener: _resource_record_post_action 04:47:11 INFO - Running post-action listener: set_extra_try_arguments 04:47:11 INFO - [mozharness: 2016-12-16 12:47:11.383603Z] Finished download-and-extract step (success) 04:47:11 INFO - [mozharness: 2016-12-16 12:47:11.383826Z] Running populate-webroot step. 04:47:11 INFO - Running pre-action listener: _resource_record_pre_action 04:47:11 INFO - Running main action method: populate_webroot 04:47:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:47:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:47:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:47:11 INFO - '--tppagecycles', 04:47:11 INFO - '7'], 04:47:11 INFO - 'tests': ['tsvgm']}}, 04:47:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:47:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:47:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:47:11 INFO - 'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:47:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:47:11 INFO - 'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['damp', 'tps']}, 04:47:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:47:11 INFO - 'tests': ['damp', 'tps']}, 04:47:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['dromaeo_dom']}, 04:47:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['basic_compositor_video']}, 04:47:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:47:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['a11yr', 04:47:11 INFO - 'ts_paint', 04:47:11 INFO - 'tpaint', 04:47:11 INFO - 'sessionrestore', 04:47:11 INFO - 'sessionrestore_no_auto_restore', 04:47:11 INFO - 'tabpaint']}, 04:47:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:11 INFO - 'ts_paint', 04:47:11 INFO - 'tpaint', 04:47:11 INFO - 'sessionrestore', 04:47:11 INFO - 'sessionrestore_no_auto_restore', 04:47:11 INFO - 'tabpaint']}, 04:47:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:47:11 INFO - 'ts_paint', 04:47:11 INFO - 'tpaint', 04:47:11 INFO - 'sessionrestore', 04:47:11 INFO - 'sessionrestore_no_auto_restore', 04:47:11 INFO - 'tabpaint']}, 04:47:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:47:11 INFO - 'ts_paint', 04:47:11 INFO - 'tpaint', 04:47:11 INFO - 'sessionrestore', 04:47:11 INFO - 'sessionrestore_no_auto_restore', 04:47:11 INFO - 'tabpaint']}, 04:47:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['a11yr', 04:47:11 INFO - 'ts_paint', 04:47:11 INFO - 'tpaint', 04:47:11 INFO - 'sessionrestore', 04:47:11 INFO - 'sessionrestore_no_auto_restore', 04:47:11 INFO - 'tabpaint']}, 04:47:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['a11yr', 04:47:11 INFO - 'ts_paint', 04:47:11 INFO - 'tpaint', 04:47:11 INFO - 'sessionrestore', 04:47:11 INFO - 'sessionrestore_no_auto_restore', 04:47:11 INFO - 'tabpaint']}, 04:47:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['tsvgx', 04:47:11 INFO - 'tsvgr_opacity', 04:47:11 INFO - 'tart', 04:47:11 INFO - 'tscrollx', 04:47:11 INFO - 'cart', 04:47:11 INFO - 'tsvg_static']}, 04:47:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:11 INFO - 'tsvgr_opacity', 04:47:11 INFO - 'tart', 04:47:11 INFO - 'tscrollx', 04:47:11 INFO - 'cart', 04:47:11 INFO - 'tsvg_static']}, 04:47:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:47:11 INFO - 'talos_options': ['--disable-e10s'], 04:47:11 INFO - 'tests': ['tp5o']}, 04:47:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:47:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:47:11 INFO - 'talos_options': ['--disable-e10s', 04:47:11 INFO - '--xperf_path', 04:47:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:11 INFO - 'tests': ['tp5n']}, 04:47:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:47:11 INFO - 'talos_options': ['--xperf_path', 04:47:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:11 INFO - 'tests': ['tp5n']}}, 04:47:11 INFO - 'talos.zip': {'path': '', 04:47:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:47:11 INFO - Running post-action listener: _resource_record_post_action 04:47:11 INFO - [mozharness: 2016-12-16 12:47:11.401444Z] Finished populate-webroot step (success) 04:47:11 INFO - [mozharness: 2016-12-16 12:47:11.401531Z] Running create-virtualenv step. 04:47:11 INFO - Running pre-action listener: _resource_record_pre_action 04:47:11 INFO - Running main action method: create_virtualenv 04:47:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:47:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:11 INFO - Using real prefix '/usr' 04:47:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:12 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:13 INFO - Installing pip.................done. 04:47:13 INFO - Return code: 0 04:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:47:14 INFO - Reading from file tmpfile_stdout 04:47:14 INFO - Output received: 04:47:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:47:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16af6dee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, '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': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:47:14 INFO - Using env: {'DISPLAY': ':0', 04:47:14 INFO - 'HOME': '/home/cltbld', 04:47:14 INFO - 'LANG': 'en_US.UTF-8', 04:47:14 INFO - 'LANGUAGE': 'en_US:en', 04:47:14 INFO - 'LOGNAME': 'cltbld', 04:47:14 INFO - 'MAIL': '/var/mail/cltbld', 04:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:14 INFO - 'MOZ_NO_REMOTE': '1', 04:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:14 INFO - 'NO_EM_RESTART': '1', 04:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:14 INFO - 'PWD': '/builds/slave/test', 04:47:14 INFO - 'SHELL': '/bin/bash', 04:47:14 INFO - 'SHLVL': '1', 04:47:14 INFO - 'TERM': 'linux', 04:47:14 INFO - 'TMOUT': '86400', 04:47:14 INFO - 'USER': 'cltbld', 04:47:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:14 INFO - '_': '/tools/buildbot/bin/python'} 04:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:47:14 INFO - Cleaning up... 04:47:14 INFO - Return code: 0 04:47:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16af6dee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, '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': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:47:14 INFO - Using env: {'DISPLAY': ':0', 04:47:14 INFO - 'HOME': '/home/cltbld', 04:47:14 INFO - 'LANG': 'en_US.UTF-8', 04:47:14 INFO - 'LANGUAGE': 'en_US:en', 04:47:14 INFO - 'LOGNAME': 'cltbld', 04:47:14 INFO - 'MAIL': '/var/mail/cltbld', 04:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:14 INFO - 'MOZ_NO_REMOTE': '1', 04:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:14 INFO - 'NO_EM_RESTART': '1', 04:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:14 INFO - 'PWD': '/builds/slave/test', 04:47:14 INFO - 'SHELL': '/bin/bash', 04:47:14 INFO - 'SHLVL': '1', 04:47:14 INFO - 'TERM': 'linux', 04:47:14 INFO - 'TMOUT': '86400', 04:47:14 INFO - 'USER': 'cltbld', 04:47:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:14 INFO - '_': '/tools/buildbot/bin/python'} 04:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:14 INFO - Downloading/unpacking psutil>=3.1.1 04:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:16 INFO - Installing collected packages: psutil 04:47:16 INFO - Running setup.py install for psutil 04:47:16 INFO - building 'psutil._psutil_linux' extension 04:47:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:47:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:47:16 INFO - building 'psutil._psutil_posix' extension 04:47:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:47:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:47:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:17 INFO - Successfully installed psutil 04:47:17 INFO - Cleaning up... 04:47:17 INFO - Return code: 0 04:47:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16af6dee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, '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': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:47:17 INFO - Using env: {'DISPLAY': ':0', 04:47:17 INFO - 'HOME': '/home/cltbld', 04:47:17 INFO - 'LANG': 'en_US.UTF-8', 04:47:17 INFO - 'LANGUAGE': 'en_US:en', 04:47:17 INFO - 'LOGNAME': 'cltbld', 04:47:17 INFO - 'MAIL': '/var/mail/cltbld', 04:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:17 INFO - 'MOZ_NO_REMOTE': '1', 04:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:17 INFO - 'NO_EM_RESTART': '1', 04:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:17 INFO - 'PWD': '/builds/slave/test', 04:47:17 INFO - 'SHELL': '/bin/bash', 04:47:17 INFO - 'SHLVL': '1', 04:47:17 INFO - 'TERM': 'linux', 04:47:17 INFO - 'TMOUT': '86400', 04:47:17 INFO - 'USER': 'cltbld', 04:47:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:17 INFO - '_': '/tools/buildbot/bin/python'} 04:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:47:19 INFO - Installing collected packages: mozsystemmonitor 04:47:19 INFO - Running setup.py install for mozsystemmonitor 04:47:19 INFO - Successfully installed mozsystemmonitor 04:47:19 INFO - Cleaning up... 04:47:19 INFO - Return code: 0 04:47:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16af6dee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, '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': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:47:19 INFO - Using env: {'DISPLAY': ':0', 04:47:19 INFO - 'HOME': '/home/cltbld', 04:47:19 INFO - 'LANG': 'en_US.UTF-8', 04:47:19 INFO - 'LANGUAGE': 'en_US:en', 04:47:19 INFO - 'LOGNAME': 'cltbld', 04:47:19 INFO - 'MAIL': '/var/mail/cltbld', 04:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:19 INFO - 'MOZ_NO_REMOTE': '1', 04:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:19 INFO - 'NO_EM_RESTART': '1', 04:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:19 INFO - 'PWD': '/builds/slave/test', 04:47:19 INFO - 'SHELL': '/bin/bash', 04:47:19 INFO - 'SHLVL': '1', 04:47:19 INFO - 'TERM': 'linux', 04:47:19 INFO - 'TMOUT': '86400', 04:47:19 INFO - 'USER': 'cltbld', 04:47:19 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:19 INFO - '_': '/tools/buildbot/bin/python'} 04:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:19 INFO - Downloading/unpacking jsonschema==2.5.1 04:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:22 INFO - warning: no files found matching '*.txt' 04:47:22 INFO - no previously-included directories found matching 'build' 04:47:22 INFO - no previously-included directories found matching 'dist' 04:47:22 INFO - no previously-included directories found matching '.git*' 04:47:22 INFO - Installing collected packages: jsonschema, functools32 04:47:22 INFO - Running setup.py install for functools32 04:47:22 INFO - warning: no files found matching '*.txt' 04:47:22 INFO - no previously-included directories found matching 'build' 04:47:22 INFO - no previously-included directories found matching 'dist' 04:47:22 INFO - no previously-included directories found matching '.git*' 04:47:22 INFO - Successfully installed jsonschema functools32 04:47:22 INFO - Cleaning up... 04:47:22 INFO - Return code: 0 04:47:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16af6dee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, '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': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:47:22 INFO - Using env: {'DISPLAY': ':0', 04:47:22 INFO - 'HOME': '/home/cltbld', 04:47:22 INFO - 'LANG': 'en_US.UTF-8', 04:47:22 INFO - 'LANGUAGE': 'en_US:en', 04:47:22 INFO - 'LOGNAME': 'cltbld', 04:47:22 INFO - 'MAIL': '/var/mail/cltbld', 04:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:22 INFO - 'MOZ_NO_REMOTE': '1', 04:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:22 INFO - 'NO_EM_RESTART': '1', 04:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:22 INFO - 'PWD': '/builds/slave/test', 04:47:22 INFO - 'SHELL': '/bin/bash', 04:47:22 INFO - 'SHLVL': '1', 04:47:22 INFO - 'TERM': 'linux', 04:47:22 INFO - 'TMOUT': '86400', 04:47:22 INFO - 'USER': 'cltbld', 04:47:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:22 INFO - '_': '/tools/buildbot/bin/python'} 04:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:47:22 INFO - Cleaning up... 04:47:22 INFO - Return code: 0 04:47:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16af6dee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, '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': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:47:22 INFO - Using env: {'DISPLAY': ':0', 04:47:22 INFO - 'HOME': '/home/cltbld', 04:47:22 INFO - 'LANG': 'en_US.UTF-8', 04:47:22 INFO - 'LANGUAGE': 'en_US:en', 04:47:22 INFO - 'LOGNAME': 'cltbld', 04:47:22 INFO - 'MAIL': '/var/mail/cltbld', 04:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:22 INFO - 'MOZ_NO_REMOTE': '1', 04:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:22 INFO - 'NO_EM_RESTART': '1', 04:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:22 INFO - 'PWD': '/builds/slave/test', 04:47:22 INFO - 'SHELL': '/bin/bash', 04:47:22 INFO - 'SHLVL': '1', 04:47:22 INFO - 'TERM': 'linux', 04:47:22 INFO - 'TMOUT': '86400', 04:47:22 INFO - 'USER': 'cltbld', 04:47:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:22 INFO - '_': '/tools/buildbot/bin/python'} 04:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:24 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:25 INFO - Downloading docopt-0.6.1.tar.gz 04:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:25 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:25 INFO - Running setup.py install for blobuploader 04:47:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:25 INFO - Running setup.py install for requests 04:47:25 INFO - Running setup.py install for docopt 04:47:26 INFO - Successfully installed blobuploader requests docopt 04:47:26 INFO - Cleaning up... 04:47:26 INFO - Return code: 0 04:47:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:26 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 0x7f16af6dee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, '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': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:47:26 INFO - Using env: {'DISPLAY': ':0', 04:47:26 INFO - 'HOME': '/home/cltbld', 04:47:26 INFO - 'LANG': 'en_US.UTF-8', 04:47:26 INFO - 'LANGUAGE': 'en_US:en', 04:47:26 INFO - 'LOGNAME': 'cltbld', 04:47:26 INFO - 'MAIL': '/var/mail/cltbld', 04:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:26 INFO - 'MOZ_NO_REMOTE': '1', 04:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:26 INFO - 'NO_EM_RESTART': '1', 04:47:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:26 INFO - 'PWD': '/builds/slave/test', 04:47:26 INFO - 'SHELL': '/bin/bash', 04:47:26 INFO - 'SHLVL': '1', 04:47:26 INFO - 'TERM': 'linux', 04:47:26 INFO - 'TMOUT': '86400', 04:47:26 INFO - 'USER': 'cltbld', 04:47:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:26 INFO - '_': '/tools/buildbot/bin/python'} 04:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:26 INFO - Running setup.py (path:/tmp/pip-fFdr3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:26 INFO - Running setup.py (path:/tmp/pip-zWIM0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:26 INFO - Running setup.py (path:/tmp/pip-8KqKI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:26 INFO - Running setup.py (path:/tmp/pip-jHjFFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:26 INFO - Running setup.py (path:/tmp/pip-HK4PQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:26 INFO - Running setup.py (path:/tmp/pip-KvaGDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:26 INFO - Running setup.py (path:/tmp/pip-XhcpEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:26 INFO - Running setup.py (path:/tmp/pip-HaurnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:26 INFO - Running setup.py (path:/tmp/pip-G95nGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:26 INFO - Running setup.py (path:/tmp/pip-CuETRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:27 INFO - Running setup.py (path:/tmp/pip-vaZM2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:27 INFO - Running setup.py (path:/tmp/pip-PBXhnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:27 INFO - Running setup.py (path:/tmp/pip-kQS71y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:27 INFO - Running setup.py (path:/tmp/pip-HPLUOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:27 INFO - Running setup.py (path:/tmp/pip-TXYTzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:27 INFO - Running setup.py (path:/tmp/pip-sYqxLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:27 INFO - Running setup.py (path:/tmp/pip-2lkkTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:27 INFO - Running setup.py install for manifestparser 04:47:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:27 INFO - Running setup.py install for mozcrash 04:47:27 INFO - Running setup.py install for mozdebug 04:47:27 INFO - Running setup.py install for mozdevice 04:47:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:47:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:27 INFO - Running setup.py install for mozfile 04:47:28 INFO - Running setup.py install for mozhttpd 04:47:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Running setup.py install for mozinfo 04:47:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Running setup.py install for mozInstall 04:47:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Running setup.py install for mozleak 04:47:28 INFO - Running setup.py install for mozlog 04:47:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Running setup.py install for moznetwork 04:47:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Running setup.py install for mozprocess 04:47:28 INFO - Running setup.py install for mozprofile 04:47:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:28 INFO - Running setup.py install for mozrunner 04:47:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:29 INFO - Running setup.py install for mozscreenshot 04:47:29 INFO - Running setup.py install for moztest 04:47:29 INFO - Running setup.py install for mozversion 04:47:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:29 INFO - Cleaning up... 04:47:29 INFO - Return code: 0 04:47:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16af6dee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, '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': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:47:29 INFO - Using env: {'DISPLAY': ':0', 04:47:29 INFO - 'HOME': '/home/cltbld', 04:47:29 INFO - 'LANG': 'en_US.UTF-8', 04:47:29 INFO - 'LANGUAGE': 'en_US:en', 04:47:29 INFO - 'LOGNAME': 'cltbld', 04:47:29 INFO - 'MAIL': '/var/mail/cltbld', 04:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:29 INFO - 'MOZ_NO_REMOTE': '1', 04:47:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:29 INFO - 'NO_EM_RESTART': '1', 04:47:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:29 INFO - 'PWD': '/builds/slave/test', 04:47:29 INFO - 'SHELL': '/bin/bash', 04:47:29 INFO - 'SHLVL': '1', 04:47:29 INFO - 'TERM': 'linux', 04:47:29 INFO - 'TMOUT': '86400', 04:47:29 INFO - 'USER': 'cltbld', 04:47:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:29 INFO - '_': '/tools/buildbot/bin/python'} 04:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:29 INFO - Running setup.py (path:/tmp/pip-mQebNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:29 INFO - Running setup.py (path:/tmp/pip-H_vww0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:29 INFO - Running setup.py (path:/tmp/pip-9ObCXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:29 INFO - Running setup.py (path:/tmp/pip-xGQdft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:29 INFO - Running setup.py (path:/tmp/pip-29fBn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:29 INFO - Running setup.py (path:/tmp/pip-6GuumI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:30 INFO - Running setup.py (path:/tmp/pip-RNHWZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:30 INFO - Running setup.py (path:/tmp/pip-ii1a_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:30 INFO - Running setup.py (path:/tmp/pip-T8jcUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:30 INFO - Running setup.py (path:/tmp/pip-2F0_xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:30 INFO - Running setup.py (path:/tmp/pip-vFxvPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:30 INFO - Running setup.py (path:/tmp/pip-lE9W1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:30 INFO - Running setup.py (path:/tmp/pip-7i_Ds4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:30 INFO - Running setup.py (path:/tmp/pip-QCDUmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:30 INFO - Running setup.py (path:/tmp/pip-F2yV4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:30 INFO - Running setup.py (path:/tmp/pip-EB5Wwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:30 INFO - Running setup.py (path:/tmp/pip-ztV_77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:32 INFO - Downloading blessings-1.6.tar.gz 04:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:32 INFO - Installing collected packages: blessings 04:47:32 INFO - Running setup.py install for blessings 04:47:32 INFO - Successfully installed blessings 04:47:32 INFO - Cleaning up... 04:47:33 INFO - Return code: 0 04:47:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:33 INFO - Reading from file tmpfile_stdout 04:47:33 INFO - Current package versions: 04:47:33 INFO - argparse == 1.2.1 04:47:33 INFO - blessings == 1.6 04:47:33 INFO - blobuploader == 1.2.4 04:47:33 INFO - docopt == 0.6.1 04:47:33 INFO - functools32 == 3.2.3-2 04:47:33 INFO - jsonschema == 2.5.1 04:47:33 INFO - manifestparser == 1.1 04:47:33 INFO - mozInstall == 1.12 04:47:33 INFO - mozcrash == 1.0 04:47:33 INFO - mozdebug == 0.1 04:47:33 INFO - mozdevice == 0.49 04:47:33 INFO - mozfile == 1.2 04:47:33 INFO - mozhttpd == 0.7 04:47:33 INFO - mozinfo == 0.9 04:47:33 INFO - mozleak == 0.1 04:47:33 INFO - mozlog == 3.4 04:47:33 INFO - moznetwork == 0.27 04:47:33 INFO - mozprocess == 0.23 04:47:33 INFO - mozprofile == 0.28 04:47:33 INFO - mozrunner == 6.13 04:47:33 INFO - mozscreenshot == 0.1 04:47:33 INFO - mozsystemmonitor == 0.3 04:47:33 INFO - moztest == 0.7 04:47:33 INFO - mozversion == 1.4 04:47:33 INFO - psutil == 3.1.1 04:47:33 INFO - requests == 1.2.3 04:47:33 INFO - wsgiref == 0.1.2 04:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16af6dee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, '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': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:47:33 INFO - Using env: {'DISPLAY': ':0', 04:47:33 INFO - 'HOME': '/home/cltbld', 04:47:33 INFO - 'LANG': 'en_US.UTF-8', 04:47:33 INFO - 'LANGUAGE': 'en_US:en', 04:47:33 INFO - 'LOGNAME': 'cltbld', 04:47:33 INFO - 'MAIL': '/var/mail/cltbld', 04:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:33 INFO - 'MOZ_NO_REMOTE': '1', 04:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:33 INFO - 'NO_EM_RESTART': '1', 04:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:33 INFO - 'PWD': '/builds/slave/test', 04:47:33 INFO - 'SHELL': '/bin/bash', 04:47:33 INFO - 'SHLVL': '1', 04:47:33 INFO - 'TERM': 'linux', 04:47:33 INFO - 'TMOUT': '86400', 04:47:33 INFO - 'USER': 'cltbld', 04:47:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:33 INFO - '_': '/tools/buildbot/bin/python'} 04:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:47:33 INFO - Cleaning up... 04:47:33 INFO - Return code: 0 04:47:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16af6dee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, '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': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:47:33 INFO - Using env: {'DISPLAY': ':0', 04:47:33 INFO - 'HOME': '/home/cltbld', 04:47:33 INFO - 'LANG': 'en_US.UTF-8', 04:47:33 INFO - 'LANGUAGE': 'en_US:en', 04:47:33 INFO - 'LOGNAME': 'cltbld', 04:47:33 INFO - 'MAIL': '/var/mail/cltbld', 04:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:33 INFO - 'MOZ_NO_REMOTE': '1', 04:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:33 INFO - 'NO_EM_RESTART': '1', 04:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:33 INFO - 'PWD': '/builds/slave/test', 04:47:33 INFO - 'SHELL': '/bin/bash', 04:47:33 INFO - 'SHLVL': '1', 04:47:33 INFO - 'TERM': 'linux', 04:47:33 INFO - 'TMOUT': '86400', 04:47:33 INFO - 'USER': 'cltbld', 04:47:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:33 INFO - '_': '/tools/buildbot/bin/python'} 04:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:47:33 INFO - Cleaning up... 04:47:33 INFO - Return code: 0 04:47:33 INFO - Running post-action listener: _resource_record_post_action 04:47:33 INFO - Running post-action listener: _start_resource_monitoring 04:47:33 INFO - Starting resource monitoring. 04:47:33 INFO - [mozharness: 2016-12-16 12:47:33.773710Z] Finished create-virtualenv step (success) 04:47:33 INFO - [mozharness: 2016-12-16 12:47:33.774226Z] Running install step. 04:47:33 INFO - Running pre-action listener: _resource_record_pre_action 04:47:33 INFO - Running main action method: install 04:47:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:33 INFO - Reading from file tmpfile_stdout 04:47:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:34 INFO - Reading from file tmpfile_stdout 04:47:34 INFO - Output received: 04:47:34 INFO - Usage: mozinstall [options] installer 04:47:34 INFO - Options: 04:47:34 INFO - -h, --help show this help message and exit 04:47:34 INFO - -d DEST, --destination=DEST 04:47:34 INFO - Directory to install application into. [default: 04:47:34 INFO - "/builds/slave/test"] 04:47:34 INFO - --app=APP Application being installed. [default: firefox] 04:47:34 INFO - mkdir: /builds/slave/test/build/application 04:47:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:47:51 INFO - Reading from file tmpfile_stdout 04:47:51 INFO - Output received: 04:47:51 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:51 INFO - Running post-action listener: _resource_record_post_action 04:47:51 INFO - [mozharness: 2016-12-16 12:47:51.077746Z] Finished install step (success) 04:47:51 INFO - [mozharness: 2016-12-16 12:47:51.077986Z] Running run-tests step. 04:47:51 INFO - Running pre-action listener: _resource_record_pre_action 04:47:51 INFO - Running main action method: run_tests 04:47:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:51 INFO - Python 2.7.3 04:47:51 INFO - Return code: 0 04:47:51 INFO - grabbing minidump binary from tooltool 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:51 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 0x2ab2f20>, '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 0x2a1fc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:47:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:47:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:47:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:51 INFO - Return code: 0 04:47:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:51 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/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:47:51 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/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:47:51 INFO - Using env: {'DISPLAY': ':0', 04:47:51 INFO - 'HOME': '/home/cltbld', 04:47:51 INFO - 'LANG': 'en_US.UTF-8', 04:47:51 INFO - 'LANGUAGE': 'en_US:en', 04:47:51 INFO - 'LOGNAME': 'cltbld', 04:47:51 INFO - 'MAIL': '/var/mail/cltbld', 04:47:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:51 INFO - 'MOZ_NO_REMOTE': '1', 04:47:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:51 INFO - 'NO_EM_RESTART': '1', 04:47:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:51 INFO - 'PWD': '/builds/slave/test', 04:47:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:51 INFO - 'SHELL': '/bin/bash', 04:47:51 INFO - 'SHLVL': '1', 04:47:51 INFO - 'TERM': 'linux', 04:47:51 INFO - 'TMOUT': '86400', 04:47:51 INFO - 'USER': 'cltbld', 04:47:51 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498', 04:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:51 INFO - '_': '/tools/buildbot/bin/python'} 04:47:51 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/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:47:51 INFO - mozversion application_buildid: 20161216030207 04:47:51 INFO - mozversion application_changeset: 63b447888a6469b9f6ae8f76ac5f0d7c6ea239da 04:47:51 INFO - mozversion application_display_name: Nightly 04:47:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:51 INFO - mozversion application_name: Firefox 04:47:51 INFO - mozversion application_remotingname: firefox 04:47:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:47:51 INFO - mozversion application_vendor: Mozilla 04:47:51 INFO - mozversion application_version: 53.0a1 04:47:51 INFO - mozversion platform_buildid: 20161216030207 04:47:51 INFO - mozversion platform_changeset: 63b447888a6469b9f6ae8f76ac5f0d7c6ea239da 04:47:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:47:51 INFO - mozversion platform_version: 53.0a1 04:47:51 INFO - using testdate: 1481892471 04:47:51 INFO - actual date: 1481892471 04:47:51 INFO - starting webserver on 'localhost:49233' 04:47:51 INFO - SUITE-START | Running 2 tests 04:47:51 INFO - TEST-START | dromaeo_css 04:47:51 INFO - operating with platform_type : linux_ 04:47:51 INFO - Initialising browser for dromaeo_css test... 04:47:51 INFO - TEST-INFO | started process 23199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps5CbN6/profile http://localhost:49233/getInfo.html) 04:47:55 INFO - PROCESS | 23199 | __metrics Screen width/height:1600/1200 04:47:55 INFO - PROCESS | 23199 | colorDepth:24 04:47:55 INFO - PROCESS | 23199 | Browser inner width/height: 1024/697 04:47:55 INFO - PROCESS | 23199 | __metrics 04:47:55 INFO - PROCESS | 23199 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:47:55 INFO - PROCESS | 23199 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:47:56 INFO - PROCESS | 23199 | console.error: PushService: 04:47:56 INFO - PROCESS | 23199 | stateChangeProcessEnqueue: Error transitioning state 04:47:56 INFO - PROCESS | 23199 | UnknownError 04:47:57 INFO - TEST-INFO | 23199: exit 0 04:47:57 INFO - Browser initialized. 04:47:57 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:57 INFO - TEST-INFO | started process 23284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps5CbN6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:08 INFO - PROCESS | 23284 | RSS: Main: 155185152 04:48:08 INFO - PROCESS | 23284 | 04:49:00 INFO - PROCESS | 23284 | 1481892540350 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:51:11 INFO - PROCESS | 23284 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49233/tests/dromaeo/cssquery-ext.html) 04:51:13 INFO - PROCESS | 23284 | RSS: Main: 301006848 04:51:13 INFO - PROCESS | 23284 | 04:54:15 INFO - PROCESS | 23284 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-ext.html (next: http://localhost:49233/tests/dromaeo/cssquery-jquery.html) 04:54:16 INFO - PROCESS | 23284 | RSS: Main: 256499712 04:54:16 INFO - PROCESS | 23284 | 04:57:18 INFO - PROCESS | 23284 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49233/tests/dromaeo/cssquery-mootools.html) 04:57:19 INFO - PROCESS | 23284 | RSS: Main: 190595072 04:57:19 INFO - PROCESS | 23284 | 05:00:21 INFO - PROCESS | 23284 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49233/tests/dromaeo/cssquery-prototype.html) 05:00:21 INFO - PROCESS | 23284 | RSS: Main: 190595072 05:00:21 INFO - PROCESS | 23284 | 05:03:24 INFO - PROCESS | 23284 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49233/tests/dromaeo/cssquery-yui.html) 05:03:25 INFO - PROCESS | 23284 | RSS: Main: 191533056 05:03:25 INFO - PROCESS | 23284 | 05:06:28 INFO - PROCESS | 23284 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-yui.html (next: http://localhost:49233/tests/dromaeo/cssquery-dojo.html) 05:06:28 INFO - PROCESS | 23284 | RSS: Main: 285069312 05:06:28 INFO - PROCESS | 23284 | 05:06:28 INFO - PROCESS | 23284 | __start_tp_report 05:06:28 INFO - PROCESS | 23284 | _x_x_mozilla_page_load 05:06:28 INFO - PROCESS | 23284 | _x_x_mozilla_page_load_details 05:06:28 INFO - PROCESS | 23284 | |i|pagename|runs| 05:06:28 INFO - PROCESS | 23284 | |0;dojo.html;2997.970020299797;3024.9697503024977;3027.1372658792243;3059.1434398368465;3072.5237588173827;5239.423663397033;5273.630845840793;5310.3893052298945;5397.298351214342;5419.729013549327;5290.947090529094;5307.230451584518;5313.681179129255;5368.221607866857;5386.057439948013;4805.735684537349;4838.830640927577;4839.927401088987;4864.318995340655;4918.606511479091;4854.223324268118;4920.68015578988;4941.085899108676;4976.4525902150735;5001.8249361272365;4890.706557606555;4926.45808961014;4958.281049247857;4981.252812078181;4999.125153098212;4751.524847515256;4788.449328327252;4797.56821886032;4827.613790896755;4862.975685121587;4834.975825120887;4839.153148199086;4861.781219845116;4896.314515967767;4913.950860491421;5291.126964050927;5363.356397232318;5370.5435038021815;5371.060064488699;5371.355437347504;5522.254495643077;5551.666899986014;5554.472325129106;5668.291463567054;5688.857778555528;5642.210090587321;5659.094544872801;5685.403032681592;5691.117876729114;5722.170285308649;5307.442718514539;5311.123664595376;5317.8404647860625;5329.280547126088;5332.146856502941;5666.9716651416475;5793.391693872167;5801.7099145042575;5805.332386775491;5846.0646296593195;5415.079436495806;5523.6409633373705;5544.750486228048;5560.304961879765;5561.860953476114;5626.634268772516;5673.234113394721;5675.545956323567;5680;5718.228039214736;5670.177824215466;5671.773129074791;5674.120511320752;5676.517496012885;5683.147527870769;5323.0684630190335;5379;5395.298611180521;5479.232907392969;5735.369109397963;4262.062346283875;4264.978675106605;4267.975685835439;4270.380794784739;4278.893027674333;3808.0670235791854;3869.400242962345;3873;3873.32216862048;3874.7868867212574;5266.894662106736;5279.973600131974;5282.445343238982;5284.762185701653;5285.260063591023;5503.11950087984;5512.724363781795;5546.195801608744;5548.667079975215;5558.888822223533;5398;5414.133738601805;5420.620556561003;5424.240606315119;5428.4028756836715;4756.5956893664425;4764.332993380929;4782.593479554207;4803.639727020487;4810.7113573185725;5871.55963302754;5880.617759845596;5886.676232807151;5886.970565147147;5887.499562537232;5575.470330318613;5623.634463759842;5709.115087161496;5712.485876271156;5779.219805326227;5898.970505147447;5936.762529498945;5951.315598706205;5969.999999999826;6005.489533389711;5685.0335442973965;5692.288463942007;5705.144228365612;5707.514861236841;5712.371639119777;5514.834554963358;5820.912686309624;5824.737886795189;5826.417358264309;5831.70841457917;5420.566354691537;5501.339839219319;5533.225348451139;5534;5622.493975542221;5570.6657600544095;5576.804811831566;5578.274824272981;5587.525060369914;5587.664740115606;5476.589255805751;5501.4223506532835;5516.310461192351;5516.862078448071;5583;5441.401445840876;5449.863753406196;5492.395836457907;5519.806806761744;5575;5501.697406642513;5547.5007249347755;5593.888122237451;5601.775928962796;5603.859903502445 05:06:28 INFO - PROCESS | 23284 | |1;ext.html;540.921566372876;561.9438056194381;569.8974184646762;570.9914351284729;580.5529742098587;30821.537676934862;41897.79051104744;43599.34600980988;43753;43799.34300985488;41098;41642.79178604103;41650;41666.79166604163;41681.791591042005;8553.529555874424;8735.21383075523;8741.4755114693;8743;8757.737267881941;7738.574378409186;8076.676932922676;10042.54808533614;10323.174146068333;10335.328203666737;10318.432486213254;10363.170946324275;10379.065884070433;10382.844257336146;10384.06543411093;10166.39001659899;10220.488975551192;10231.334963227366;10238.84641730371;10239.436830974293;10065.396076235449;10100.141487973531;10115.645952391631;10133.391996480235;10143.543540540693;39248;39509;39531.80234098811;39542.802285988386;39590.802045989585;3185.856636451342;3203.1191422358806;3222.0817067135754;3415.743819213544;3520.6831385175456;29629.555556666666;29782.602242254627;29859.70140298591;30415.69584304173;31314.530282045787;4106.589341065899;4182.184474027566;4242.639375653073;4251.44731184944;4318.69769116162;300355;302665;303041;303492;304765.4761726199;55536.44463555393;55967;55968;55987;56021.43978560244;52640.473595264324;57668.71165644229;58109;58117.12824307639;58253.70873145692;16042;16259.187040647921;16274.186290685418;16289.266982985793;16296;11330.773384532264;11791.76416471683;12713.618591442271;12802.42389092493;12803.359832008362;15857;16163.595910102107;16342.918285408734;16741.49775506737;17009.659806803793;5962.642241465526;5973.641581505123;5989.490893274121;6031.095335699592;6046.244219472566;865.9567021648892;934.4206591912922;980.8773903262093;1038.8337865941412;1079.1528650009861;29356;30273;30330.090097297118;30946.53580196299;30988.84505577458;1001.7095042437758;1038.6676263595577;1102.459794700591;1107.164091111222;1133.0425790207262;15126;15453.613659658598;16228.188590570424;16270;16682.332706691595;512341.4382928136;515238;515310;515746;517122;47117.528824712;47151.05697886023;47312.5268747315;47329;47360.526394735614;1199.0827017331749;1239.8264243005985;1268.5623459906133;1319.6502926724427;1328.156620545941;25499.107531236317;27902.86048569744;28486.287842804097;28731.425371492034;29395.706042940154;46227.76886115548;46752.29871551997;46818.76590617025;46881;46956.530434696586;392433;397301;397315;397419;397943;24071.638925416482;24287.907044182703;24495.142670006466;24664.50670986534;25392.619110713724;39938.2012359757;39966;40004.39993400043;40641;41069.1786164281;34244.82877585596;34786.782462613686;34835.65164348324;35216.64783352236;35393.646063540065;33772.831135844164;33978.49032264567;34099.48850767191;34364.82817585896;34454;34216.65783342135;35012.47481287732;35181.82409087938;35200.64799352076;35434;29354.70645293605;32545.837270813496;32668.346633067682;32675.34649306953;32737.508937366434;24484.755152448248;24981.375465613506;25002.37494062663;25487.2353829378;25515.234542963743 05:06:28 INFO - PROCESS | 23284 | |2;jquery.html;346.8231202086938;364.4878945082159;372.10323121277725;374.14321204441825;390.3013605645894;14024.158550486965;17139.228734706936;17447.38934137304;17525.12374381279;18291.359802406918;17936.64126717468;18042.18810153543;18368.17343219555;18377.908110459462;18474.907625461852;6017.75928962842;6251.624902505841;6286.559940804145;6337.429631333179;6415;4530.569595888385;4654.557817007379;4718.716876987374;6148.56960012797;6198.194234749499;7135.89296160558;7156.85686286274;7290.5625662460425;7294.307040831139;7295.270472952715;6987.965060174666;7127.501074924758;7157.069580954495;7168.856622867565;7265.7456989005395;6702.6648667566915;6892.310768923117;6919.723211071551;6924.099867017306;6941.236463988957;24615.38461538458;24991.250262492154;25024.749752502423;25034.123805666713;25240.747592524207;2370.668106465096;2421.8183636227177;2502.94994100117;2682.28919336376;2709.7290270972944;15147.848521514754;15237.390504379811;15373.538793836204;15520.844791552054;15785.605359866095;1960.7549056367955;1984.7122167285663;2063.123172651617;2080.854340196187;2139.5079131799616;58784.706076469774;68566.31433685649;83625.58187209086;84215.5789221056;90830.54584727035;16570.917145414194;16742.832571674127;17106;17160.22778974949;17353.132343382782;29730.702692973227;29848.25379365533;29876.55185172224;30000.549991749704;30110;9422.717318480456;9433.952830235805;9460.297146513694;9784.266180036526;10116.190704743603;7730.497517661334;7786.065672119382;8006.239407256301;8022.438429309892;8073.475224110414;8189.836203275901;8443.704470343508;8489.95755021221;8670.95664521686;8691.521966291915;3174.7142757151505;3271.4275001874576;3272.541844141822;3451.706604938558;3466.9306613868084;908.4957848394205;929.3262384770987;971.8299297623029;1007.6120693533043;1008.2236677758085;17127.82872171287;17973.191206395742;18880.150393232336;19343.129559169873;20123.899380503004;947.6351604632266;965.232640051161;985.8373368394134;1008.6268080810147;1086.3590481615884;9996.650117246007;10379.688609341732;10500.579976800995;10513.158947284199;10533.36799792015;450438;453582;454885;456093;457226;82310.58844705738;82406.58796705978;84009.57995209986;84225.57887210525;86974.56512717396;999.8200323941614;1061.0874647802884;1092.415557676639;1093.792179485895;1102.9669109926715;16069.598260043593;16362.590935226715;16836;16881;17047.48857534276;39881.401778973915;40165.1966960665;40495.508330958866;41538;41737.37393939154;54928.72535637296;55425.44574554203;56528.717356412955;56746;57020.714896425256;6413.807585772434;7941.166177551274;8112.1076681566165;8187.426880118334;8203.58982050907;10490.737731556772;12224.44989975471;12337.383130843602;12498.875011250135;12568.748625027265;10643.627473038407;10810.837837432287;11035.889641103486;11090.390028548507;11316.20786544934;10804.891951080388;10825.56697732082;11129.888701113208;11384.48769805344;11607.535698571963;10952.726181845517;11297.209195356247;11378.487968041292;11473.139514536277;11694.199385200014;7100;7947;8032;8119.431639785158;8277.089520152898;10613.787724245318;11014.3942083183;11190.552377904793;11202.21584489078;11598.88401115978 05:06:28 INFO - PROCESS | 23284 | |3;mootools.html;1283.3326670131526;1351.5945216435066;1360.5578187089193;1462.2469428244456;1660.5350501859475;6862.21084575274;7496.362809161221;7740.109887362955;7760.068791744999;8072.112067672551;7837.490563113393;7939.444238903265;7941.642626081826;7942.801429964254;7945.721899733496;1802.0629272778147;1855.1466325490292;2116.50262188386;2142.753583337913;2148.3018019143765;2121.618108740426;2190.321000489845;2194.264921251383;2194.7476040255337;2196.077647388093;2066.297458863986;2085.2701554455894;2085.384811480617;2090.3833369156137;2145.2598853395552;2089.8014688604558;2116.947076323089;2117.428294360514;2122.0450797141193;2125.192426877792;2064.349729835112;2091.5712278982774;2118.195085867376;2119.98240844394;2120.7349081364828;7610.08678958523;7646.732364367221;7658.770236892902;7667.693292268303;7675.155732869436;4581.633469322446;4688.320193571947;4694.319323698079;4702.8118875244945;4703.1064097821645;2968.391479746647;3088.3514461963014;3114.065780265934;3118.5322201669705;3120.0951724000015;945.3193700535672;1007.5365331947313;1032.1639472027682;1039.3555995282898;1051.5530899367739;10435.582576696923;10516.053555179995;10532.578696852117;10546.103581195608;10549.261551691385;3768.3593789055376;4045.37296719009;4069.89825254371;4099.139180772071;4107.219628270619;8985.191332780081;8991.910080899239;8996.50519221436;9004.50475223869;9007.279417646572;4726.125666751662;4784.162771514971;4807.230843065093;4814.855554333376;4815.061063092663;3870.1098747288283;3891.6302951220155;4272.33778764292;4393.956060439355;4401.361802538614;3395.6774106459848;3447.3450044491465;3492.5285086513504;3495.7727747696317;3506.2286297014616;1133.5862410220375;1144.8053830848776;1149.4769879704713;1163.5578480177478;1172;857.9785505362416;876.5398165962921;888.6045709659139;918.2699753695828;957.3346524165638;5397;5502.147167189092;5521.643448213997;5562.16567514876;5605.159226116115;874.9956250218709;892.0041382655987;907.9921287371013;933.4912472702258;951.8619800129081;3710.239400922804;3879.8060096995036;3891.280113179071;4003.4195041718785;4007.499062617173;9227.354085214105;9552.95223523878;9608.423494590346;9614.95192524033;9642.951785241028;9508.429494230368;9509.33434659581;9513.904860951441;9552.808943821085;9554.283428742872;7242.298059955906;7398.630068496554;7409.147947985943;7411.443596844723;7427.591482468516;5194.441807361969;5327.493888080626;5430.51125398716;5504.504594586507;5672.290963629546;8351.791205219919;8632.654693812428;8644.308455323684;8807.51558664254;8839.69061082859;8523.190296921783;8839.337049721426;8839.734807955772;8849.469031858109;8963.910360896307;6203.658798766111;6351.618902865843;6874.621895795779;6939.167299924042;7107.75122870697;7416.44376671741;7550.093988721389;7556.206598307099;7581.3176814087;7585.810354741176;6777.356151165632;6864.112369098538;6880.449564034765;6888.41448476885;6987.615681137586;6686.398224159654;6747.831304217238;6777.695003724745;6814.318568143344;6819.829504262235;6306.243250809932;6329.113924050729;6355.269144048493;6370.617762934239;6449.645269510222;4632.953670463387;4655.767211639472;4699.953000469952;4719.929201062056;4834.685745426536;4887.535684110004;4923.8276660316715;4936.851894443173;4946.851594452172;4978.303037574815 05:06:28 INFO - PROCESS | 23284 | |4;prototype.html;359.7499737682312;361.925805209932;363.8671884762062;367.53873888270226;373.4920508108973;5072.898542029157;5152.943646552457;5190.14362630166;5199.194124910645;5209.661372010822;5052.736815796051;5092.643514953955;5113.923291150636;5190.520701600045;5237.3453318335205;3995.7802320872343;4093.488313960755;4158.8336466541305;4163.583641635827;4176.164767046595;4018.63832255097;4143.97928010361;4148.274052040896;4149.481314835631;4153.7507749535125;4099.590040995891;4117.135401565675;4132;4141.337386018237;4145.129522800215;4110.17796440713;4114.855980040684;4120.58794120587;4131.624316018301;4187.769672668002;3393.9151521212166;3528.153243221634;3529.6058057067316;3539.610642829287;3564.590072141685;4965.652404331699;5016.3227964224725;5023.2214006829;5032.547070763649;5045.949540504622;4511.255657804048;4547.1360441516335;4583.381243532114;4597.149527337453;4599;5139.922901156486;5265.445824068738;5315.548178404841;5326.9612425577025;5337.973310133424;3838.2323535293053;3862.613738626143;3865.922681546381;3886.591907849663;3910.8658489038144;5599.720013999325;5607.747651355739;5618.101103823409;5646.858828529279;5649.887002259973;3790.962090379116;3921.8039098044983;3961.8613348532663;3982.203559288154;3986.5814089520763;3977.880663580097;3993.4209539617173;3994.201159768;4000.819963101609;4012.25773231953;4562.703424277412;4568.931466028012;4584;4618.838340658061;4632.143053535106;5208.7916483341;5310.247618285956;5334;5394.406615272317;5466.753996070186;1336.1048097774515;1337.7926421404698;1342.825432693763;1344.6571124363224;1350.2236214176692;856.905740368559;891.3893982621925;893.8659201119884;895.4135041547796;905.968291109808;5132.409772876093;5145.507802737239;5150.175971844562;5185.818496352609;5206.73966301691;5396.217548455452;5399.865003374868;5439;5491.780328786804;5502.504774570308;5114.462981386975;5177.508136727005;5186.481351864783;5215.478452154754;5396.541293989976;2893.392387598628;2909.898153564615;2911.505044142501;2941.3970136122043;2941.4557357387544;5599.8600034998635;5628.352739435018;5636.774529018793;5654.830355089354;5670.376258611549;5422.8373148805595;5452.809151679672;5464.316960379952;5509.531689806331;5532.972335138298;5532.640378375393;5543.916841247304;5549.667019978814;5549.916751248735;5593.636413633101;5301.602379821452;5387.111126664213;5428.91856622143;5441.972790136182;5479.424660410599;5529.391766905717;5543.695096769717;5545.2513910623165;5555.694436805853;5569.916451253153;5769.451902069297;5778.595498315078;5794.783095549982;5813.331466881363;5848;3857.5756666767193;3912.7065470089287;3921.392184211452;3933.213357328603;3955.4066889966734;5349.732513374238;5483.4516548344845;5606.85982850432;5613.410591887793;5623.775048997994;5370.275012873212;5458.399576046552;5492.890142197213;5498.477644623755;5499.807506737245;5475.4524547544925;5478.315210598676;5489.862753431196;5505.201745746765;5511.751971161388;5213.800825810009;5345.9150931137665;5422.728863556886;5435.271313956883;5457.426970168075;5489.780408783604;5509.559235261089;5525.585581081355;5527.44725527444;5539.307586551681;5227.268182454535;5380.542653874464;5406.594505412031;5444.646098003617;5458.4541545845095 05:06:28 INFO - PROCESS | 23284 | |5;yui.html;686.1731613405847;736.8231624410143;741.2291217134181;762.3481922955873;809.8906647602573;14787;14990;15100.093994360346;15206.771898421519;15842.28709708063;13362.131461455;13669.453221871137;13786.379612917417;13834.377453014613;13949.372278247478;665.9001149827516;774.0401901641966;791.8574656561816;794.8966634337557;795.1928792275816;682.0519477925687;690.6650274616807;690.8445599740069;770.1335997003371;781.6873250699737;822.9135940726227;828.5857071464268;828.8052307707713;828.8508068547659;829.1128492513013;820.9343252539842;825.7275099217244;825.8719898415756;826.4710585225461;826.4834478450969;507.6294305157256;525.6005435868767;527.9260903473516;605.966671833049;606.5147881694671;11010.559577616887;13226.404811783494;13797.310134493235;13829.170249785046;14366.640833979234;14674.413023479048;14688.796680498011;14883.925580372028;15034.248287585686;15080.472183473526;11594.188406811527;11693.88306116945;11772;11964.760704785942;12158.817617735742;3674.577423596267;3758.774473531597;3779.433085037239;3871.9612803871883;3874.5156855393075;74535.25464745337;74638.62680686616;75032;75048.62475687641;75065;10420.583176673;10584.57661693539;10717.83923241152;10945.507452164671;11346.205765596329;21044.47388815292;21214.46963825917;21438.464038399165;21694.674579881314;21872.23447179373;7523.285287897641;7667.53994760305;7992.840143197103;8028.879566806502;8215.383846211438;4381.759003254851;4466.57567531084;4486.955130448654;4497.482789479186;4539.659525535598;3175.079227024183;3269.3134441767497;3281.9835900820344;3297.1427428868187;3326.86692532296;519.7713006277226;532.4515748778764;535.1117145538387;538.251829956361;545.1033050631768;589.7523040323075;659.9538032337787;692.1693967239232;694.979150625482;714.6069661686051;8440.198181172902;9129.680461183827;9318.813623727623;9450.196733277748;9597.520123993912;640.7917426836296;652.4943169043934;673.8989151627295;684.7295318349225;704.7842471736215;4221;4839.201531747222;5064.316317297118;5174.793008279702;5260.105782017066;71647;71805.64097179481;73562;74714.25285747182;79339;64166;64419.35580644134;65770;66793;66956.33043669598;58391.12413313804;60493.69753151206;60813.391866080776;61082.694586526784;62631.6868415655;9068.183863452321;9307.441553506811;9319.347645664739;9343.159115679622;9545.236381089635;41522;42376.364354535326;42760.78619607007;42868.78565607152;43991.78004109959;52845.735771322434;56929.71535142298;57389.42610573841;57563.71218143882;59419.40580594139;12638.2417054977;13023.934880325538;13069.346532673519;13533.052686311863;13786.724265514835;13401.86598134006;13403.865961340261;13794.784061747732;13978.252718410198;14326;12560.685982850502;13063.542776002794;13351.866481335452;13703.931480342535;14139.787903181255;13120.868791312347;13163.144395614254;13297.800532992207;13338.733225335245;13382.330883455594;12403;13129.015323850941;13371.130876492996;13489.39297731624;13493.190408575125;10347.689569312932;10418.238412382823;10720.785584288427;10942.17933654995;10970.506327215455;10862.782744344911;11285.272689322068;11675.824862626898;11709.941450292694;11749.353785541878 05:06:28 INFO - PROCESS | 23284 | __end_tp_report 05:06:28 INFO - PROCESS | 23284 | __start_cc_report 05:06:28 INFO - PROCESS | 23284 | _x_x_mozilla_cycle_collect,1568 05:06:28 INFO - PROCESS | 23284 | __end_cc_report 05:06:28 INFO - PROCESS | 23284 | __startTimestamp1481893588751__endTimestamp 05:06:28 INFO - PROCESS | 23284 | 05:06:28 INFO - PROCESS | 23284 | ------- Summary: start ------- 05:06:28 INFO - PROCESS | 23284 | Number of tests: 6 05:06:28 INFO - PROCESS | 23284 | 05:06:28 INFO - PROCESS | 23284 | [#0] dojo.html Cycles:165 Average:5272.47 Median:5476.59 stddev:603.25 (11.0%) stddev-sans-first:578.11 05:06:28 INFO - PROCESS | 23284 | Values: 2998.0 3025.0 3027.1 3059.1 3072.5 5239.4 5273.6 5310.4 5397.3 5419.7 5290.9 5307.2 5313.7 5368.2 5386.1 4805.7 4838.8 4839.9 4864.3 4918.6 4854.2 4920.7 4941.1 4976.5 5001.8 4890.7 4926.5 4958.3 4981.3 4999.1 4751.5 4788.4 4797.6 4827.6 4863.0 4835.0 4839.2 4861.8 4896.3 4914.0 5291.1 5363.4 5370.5 5371.1 5371.4 5522.3 5551.7 5554.5 5668.3 5688.9 5642.2 5659.1 5685.4 5691.1 5722.2 5307.4 5311.1 5317.8 5329.3 5332.1 5667.0 5793.4 5801.7 5805.3 5846.1 5415.1 5523.6 5544.8 5560.3 5561.9 5626.6 5673.2 5675.5 5680.0 5718.2 5670.2 5671.8 5674.1 5676.5 5683.1 5323.1 5379.0 5395.3 5479.2 5735.4 4262.1 4265.0 4268.0 4270.4 4278.9 3808.1 3869.4 3873.0 3873.3 3874.8 5266.9 5280.0 5282.4 5284.8 5285.3 5503.1 5512.7 5546.2 5548.7 5558.9 5398.0 5414.1 5420.6 5424.2 5428.4 4756.6 4764.3 4782.6 4803.6 4810.7 5871.6 5880.6 5886.7 5887.0 5887.5 5575.5 5623.6 5709.1 5712.5 5779.2 5899.0 5936.8 5951.3 5970.0 6005.5 5685.0 5692.3 5705.1 5707.5 5712.4 5514.8 5820.9 5824.7 5826.4 5831.7 5420.6 5501.3 5533.2 5534.0 5622.5 5570.7 5576.8 5578.3 5587.5 5587.7 5476.6 5501.4 5516.3 5516.9 5583.0 5441.4 5449.9 5492.4 5519.8 5575.0 5501.7 5547.5 5593.9 5601.8 5603.9 05:06:28 INFO - PROCESS | 23284 | 05:06:28 INFO - PROCESS | 23284 | [#1] ext.html Cycles:180 Average:55132.80 Median:34038.99 stddev:109882.29 (322.8%) stddev-sans-first:110114.09 05:06:28 INFO - PROCESS | 23284 | Values: 540.9 561.9 569.9 571.0 580.6 30821.5 41897.8 43599.3 43753.0 43799.3 41098.0 41642.8 41650.0 41666.8 41681.8 8553.5 8735.2 8741.5 8743.0 8757.7 7738.6 8076.7 10042.5 10323.2 10335.3 10318.4 10363.2 10379.1 10382.8 10384.1 10166.4 10220.5 10231.3 10238.8 10239.4 10065.4 10100.1 10115.6 10133.4 10143.5 39248.0 39509.0 39531.8 39542.8 39590.8 3185.9 3203.1 3222.1 3415.7 3520.7 29629.6 29782.6 29859.7 30415.7 31314.5 4106.6 4182.2 4242.6 4251.4 4318.7 300355.0 302665.0 303041.0 303492.0 304765.5 55536.4 55967.0 55968.0 55987.0 56021.4 52640.5 57668.7 58109.0 58117.1 58253.7 16042.0 16259.2 16274.2 16289.3 16296.0 11330.8 11791.8 12713.6 12802.4 12803.4 15857.0 16163.6 16342.9 16741.5 17009.7 5962.6 5973.6 5989.5 6031.1 6046.2 866.0 934.4 980.9 1038.8 1079.2 29356.0 30273.0 30330.1 30946.5 30988.8 1001.7 1038.7 1102.5 1107.2 1133.0 15126.0 15453.6 16228.2 16270.0 16682.3 512341.4 515238.0 515310.0 515746.0 517122.0 47117.5 47151.1 47312.5 47329.0 47360.5 1199.1 1239.8 1268.6 1319.7 1328.2 25499.1 27902.9 28486.3 28731.4 29395.7 46227.8 46752.3 46818.8 46881.0 46956.5 392433.0 397301.0 397315.0 397419.0 397943.0 24071.6 24287.9 24495.1 24664.5 25392.6 39938.2 39966.0 40004.4 40641.0 41069.2 34244.8 34786.8 34835.7 35216.6 35393.6 33772.8 33978.5 34099.5 34364.8 34454.0 34216.7 35012.5 35181.8 35200.6 35434.0 29354.7 32545.8 32668.3 32675.3 32737.5 24484.8 24981.4 25002.4 25487.2 25515.2 05:06:28 INFO - PROCESS | 23284 | 05:06:28 INFO - PROCESS | 23284 | [#2] jquery.html Cycles:180 Average:28419.65 Median:3362.12 stddev:74753.91 (2223.4%) stddev-sans-first:74933.89 05:06:28 INFO - PROCESS | 23284 | Values: 346.8 364.5 372.1 374.1 390.3 14024.2 17139.2 17447.4 17525.1 18291.4 17936.6 18042.2 18368.2 18377.9 18474.9 6017.8 6251.6 6286.6 6337.4 6415.0 4530.6 4654.6 4718.7 6148.6 6198.2 7135.9 7156.9 7290.6 7294.3 7295.3 6988.0 7127.5 7157.1 7168.9 7265.7 6702.7 6892.3 6919.7 6924.1 6941.2 24615.4 24991.3 25024.7 25034.1 25240.7 2370.7 2421.8 2502.9 2682.3 2709.7 15147.8 15237.4 15373.5 15520.8 15785.6 1960.8 1984.7 2063.1 2080.9 2139.5 58784.7 68566.3 83625.6 84215.6 90830.5 16570.9 16742.8 17106.0 17160.2 17353.1 29730.7 29848.3 29876.6 30000.5 30110.0 9422.7 9434.0 9460.3 9784.3 10116.2 7730.5 7786.1 8006.2 8022.4 8073.5 8189.8 8443.7 8490.0 8671.0 8691.5 3174.7 3271.4 3272.5 3451.7 3466.9 908.5 929.3 971.8 1007.6 1008.2 17127.8 17973.2 18880.2 19343.1 20123.9 947.6 965.2 985.8 1008.6 1086.4 9996.7 10379.7 10500.6 10513.2 10533.4 450438.0 453582.0 454885.0 456093.0 457226.0 82310.6 82406.6 84009.6 84225.6 86974.6 999.8 1061.1 1092.4 1093.8 1103.0 16069.6 16362.6 16836.0 16881.0 17047.5 39881.4 40165.2 40495.5 41538.0 41737.4 54928.7 55425.4 56528.7 56746.0 57020.7 6413.8 7941.2 8112.1 8187.4 8203.6 10490.7 12224.4 12337.4 12498.9 12568.7 10643.6 10810.8 11035.9 11090.4 11316.2 10804.9 10825.6 11129.9 11384.5 11607.5 10952.7 11297.2 11378.5 11473.1 11694.2 7100.0 7947.0 8032.0 8119.4 8277.1 10613.8 11014.4 11190.6 11202.2 11598.9 05:06:28 INFO - PROCESS | 23284 | 05:06:28 INFO - PROCESS | 23284 | [#3] mootools.html Cycles:180 Average:5149.98 Median:5362.25 stddev:2843.01 (53.0%) stddev-sans-first:2836.13 05:06:28 INFO - PROCESS | 23284 | Values: 1283.3 1351.6 1360.6 1462.2 1660.5 6862.2 7496.4 7740.1 7760.1 8072.1 7837.5 7939.4 7941.6 7942.8 7945.7 1802.1 1855.1 2116.5 2142.8 2148.3 2121.6 2190.3 2194.3 2194.7 2196.1 2066.3 2085.3 2085.4 2090.4 2145.3 2089.8 2116.9 2117.4 2122.0 2125.2 2064.3 2091.6 2118.2 2120.0 2120.7 7610.1 7646.7 7658.8 7667.7 7675.2 4581.6 4688.3 4694.3 4702.8 4703.1 2968.4 3088.4 3114.1 3118.5 3120.1 945.3 1007.5 1032.2 1039.4 1051.6 10435.6 10516.1 10532.6 10546.1 10549.3 3768.4 4045.4 4069.9 4099.1 4107.2 8985.2 8991.9 8996.5 9004.5 9007.3 4726.1 4784.2 4807.2 4814.9 4815.1 3870.1 3891.6 4272.3 4394.0 4401.4 3395.7 3447.3 3492.5 3495.8 3506.2 1133.6 1144.8 1149.5 1163.6 1172.0 858.0 876.5 888.6 918.3 957.3 5397.0 5502.1 5521.6 5562.2 5605.2 875.0 892.0 908.0 933.5 951.9 3710.2 3879.8 3891.3 4003.4 4007.5 9227.4 9553.0 9608.4 9615.0 9643.0 9508.4 9509.3 9513.9 9552.8 9554.3 7242.3 7398.6 7409.1 7411.4 7427.6 5194.4 5327.5 5430.5 5504.5 5672.3 8351.8 8632.7 8644.3 8807.5 8839.7 8523.2 8839.3 8839.7 8849.5 8963.9 6203.7 6351.6 6874.6 6939.2 7107.8 7416.4 7550.1 7556.2 7581.3 7585.8 6777.4 6864.1 6880.4 6888.4 6987.6 6686.4 6747.8 6777.7 6814.3 6819.8 6306.2 6329.1 6355.3 6370.6 6449.6 4633.0 4655.8 4700.0 4719.9 4834.7 4887.5 4923.8 4936.9 4946.9 4978.3 05:06:28 INFO - PROCESS | 23284 | 05:06:28 INFO - PROCESS | 23284 | [#4] prototype.html Cycles:180 Average:4555.21 Median:5202.97 stddev:1332.29 (25.6%) stddev-sans-first:1298.28 05:06:28 INFO - PROCESS | 23284 | Values: 359.7 361.9 363.9 367.5 373.5 5072.9 5152.9 5190.1 5199.2 5209.7 5052.7 5092.6 5113.9 5190.5 5237.3 3995.8 4093.5 4158.8 4163.6 4176.2 4018.6 4144.0 4148.3 4149.5 4153.8 4099.6 4117.1 4132.0 4141.3 4145.1 4110.2 4114.9 4120.6 4131.6 4187.8 3393.9 3528.2 3529.6 3539.6 3564.6 4965.7 5016.3 5023.2 5032.5 5045.9 4511.3 4547.1 4583.4 4597.1 4599.0 5139.9 5265.4 5315.5 5327.0 5338.0 3838.2 3862.6 3865.9 3886.6 3910.9 5599.7 5607.7 5618.1 5646.9 5649.9 3791.0 3921.8 3961.9 3982.2 3986.6 3977.9 3993.4 3994.2 4000.8 4012.3 4562.7 4568.9 4584.0 4618.8 4632.1 5208.8 5310.2 5334.0 5394.4 5466.8 1336.1 1337.8 1342.8 1344.7 1350.2 856.9 891.4 893.9 895.4 906.0 5132.4 5145.5 5150.2 5185.8 5206.7 5396.2 5399.9 5439.0 5491.8 5502.5 5114.5 5177.5 5186.5 5215.5 5396.5 2893.4 2909.9 2911.5 2941.4 2941.5 5599.9 5628.4 5636.8 5654.8 5670.4 5422.8 5452.8 5464.3 5509.5 5533.0 5532.6 5543.9 5549.7 5549.9 5593.6 5301.6 5387.1 5428.9 5442.0 5479.4 5529.4 5543.7 5545.3 5555.7 5569.9 5769.5 5778.6 5794.8 5813.3 5848.0 3857.6 3912.7 3921.4 3933.2 3955.4 5349.7 5483.5 5606.9 5613.4 5623.8 5370.3 5458.4 5492.9 5498.5 5499.8 5475.5 5478.3 5489.9 5505.2 5511.8 5213.8 5345.9 5422.7 5435.3 5457.4 5489.8 5509.6 5525.6 5527.4 5539.3 5227.3 5380.5 5406.6 5444.6 5458.5 05:06:28 INFO - PROCESS | 23284 | 05:06:28 INFO - PROCESS | 23284 | [#5] yui.html Cycles:180 Average:17058.78 Median:4689.43 stddev:21581.96 (460.2%) stddev-sans-first:21607.49 05:06:28 INFO - PROCESS | 23284 | Values: 686.2 736.8 741.2 762.3 809.9 14787.0 14990.0 15100.1 15206.8 15842.3 13362.1 13669.5 13786.4 13834.4 13949.4 665.9 774.0 791.9 794.9 795.2 682.1 690.7 690.8 770.1 781.7 822.9 828.6 828.8 828.9 829.1 820.9 825.7 825.9 826.5 826.5 507.6 525.6 527.9 606.0 606.5 11010.6 13226.4 13797.3 13829.2 14366.6 14674.4 14688.8 14883.9 15034.2 15080.5 11594.2 11693.9 11772.0 11964.8 12158.8 3674.6 3758.8 3779.4 3872.0 3874.5 74535.3 74638.6 75032.0 75048.6 75065.0 10420.6 10584.6 10717.8 10945.5 11346.2 21044.5 21214.5 21438.5 21694.7 21872.2 7523.3 7667.5 7992.8 8028.9 8215.4 4381.8 4466.6 4487.0 4497.5 4539.7 3175.1 3269.3 3282.0 3297.1 3326.9 519.8 532.5 535.1 538.3 545.1 589.8 660.0 692.2 695.0 714.6 8440.2 9129.7 9318.8 9450.2 9597.5 640.8 652.5 673.9 684.7 704.8 4221.0 4839.2 5064.3 5174.8 5260.1 71647.0 71805.6 73562.0 74714.3 79339.0 64166.0 64419.4 65770.0 66793.0 66956.3 58391.1 60493.7 60813.4 61082.7 62631.7 9068.2 9307.4 9319.3 9343.2 9545.2 41522.0 42376.4 42760.8 42868.8 43991.8 52845.7 56929.7 57389.4 57563.7 59419.4 12638.2 13023.9 13069.3 13533.1 13786.7 13401.9 13403.9 13794.8 13978.3 14326.0 12560.7 13063.5 13351.9 13703.9 14139.8 13120.9 13163.1 13297.8 13338.7 13382.3 12403.0 13129.0 13371.1 13489.4 13493.2 10347.7 10418.2 10720.8 10942.2 10970.5 10862.8 11285.3 11675.8 11709.9 11749.4 05:06:28 INFO - PROCESS | 23284 | -------- Summary: end -------- 05:06:28 INFO - PROCESS | 23284 | 05:06:29 INFO - TEST-INFO | 23284: exit 0 05:06:29 INFO - TEST-OK | dromaeo_css | took 1118153ms 05:06:29 INFO - TEST-START | kraken 05:06:29 INFO - operating with platform_type : linux_ 05:06:29 INFO - Initialising browser for kraken test... 05:06:29 INFO - TEST-INFO | started process 23584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAVgZxh/profile http://localhost:49233/getInfo.html) 05:06:33 INFO - PROCESS | 23584 | __metrics Screen width/height:1600/1200 05:06:33 INFO - PROCESS | 23584 | colorDepth:24 05:06:33 INFO - PROCESS | 23584 | Browser inner width/height: 1024/697 05:06:33 INFO - PROCESS | 23584 | __metrics 05:06:33 INFO - PROCESS | 23584 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:06:33 INFO - PROCESS | 23584 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:34 INFO - PROCESS | 23584 | console.error: PushService: 05:06:34 INFO - PROCESS | 23584 | stateChangeProcessEnqueue: Error transitioning state 05:06:34 INFO - PROCESS | 23584 | UnknownError 05:06:35 INFO - TEST-INFO | 23584: exit 0 05:06:35 INFO - Browser initialized. 05:06:35 INFO - Running cycle 1/1 for kraken test... 05:06:35 INFO - TEST-INFO | started process 23668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAVgZxh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:47 INFO - PROCESS | 23668 | RSS: Main: 154353664 05:06:47 INFO - PROCESS | 23668 | 05:06:49 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:50 INFO - PROCESS | 23668 | RSS: Main: 208621568 05:06:50 INFO - PROCESS | 23668 | 05:06:53 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-dft) 05:06:53 INFO - PROCESS | 23668 | RSS: Main: 186351616 05:06:53 INFO - PROCESS | 23668 | 05:06:56 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-fft) 05:06:57 INFO - PROCESS | 23668 | RSS: Main: 268148736 05:06:57 INFO - PROCESS | 23668 | 05:06:59 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-oscillator) 05:06:59 INFO - PROCESS | 23668 | RSS: Main: 178786304 05:06:59 INFO - PROCESS | 23668 | 05:07:02 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49233/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:07:02 INFO - PROCESS | 23668 | RSS: Main: 184197120 05:07:02 INFO - PROCESS | 23668 | 05:07:05 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49233/tests/kraken/driver.html?testName=imaging-darkroom) 05:07:06 INFO - PROCESS | 23668 | RSS: Main: 223010816 05:07:06 INFO - PROCESS | 23668 | 05:07:09 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49233/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:10 INFO - PROCESS | 23668 | RSS: Main: 223088640 05:07:10 INFO - PROCESS | 23668 | 05:07:13 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49233/tests/kraken/driver.html?testName=json-parse-financial) 05:07:13 INFO - PROCESS | 23668 | RSS: Main: 221708288 05:07:13 INFO - PROCESS | 23668 | 05:07:15 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49233/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:15 INFO - PROCESS | 23668 | RSS: Main: 183472128 05:07:15 INFO - PROCESS | 23668 | 05:07:17 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:18 INFO - PROCESS | 23668 | RSS: Main: 191176704 05:07:18 INFO - PROCESS | 23668 | 05:07:20 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:20 INFO - PROCESS | 23668 | RSS: Main: 199925760 05:07:20 INFO - PROCESS | 23668 | 05:07:23 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:24 INFO - PROCESS | 23668 | RSS: Main: 208457728 05:07:24 INFO - PROCESS | 23668 | 05:07:27 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:27 INFO - PROCESS | 23668 | RSS: Main: 205324288 05:07:27 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49233/tests/kraken/driver.html?testName=ai-astar) 05:07:29 INFO - PROCESS | 23668 | RSS: Main: 257138688 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | __start_tp_report 05:07:29 INFO - PROCESS | 23668 | _x_x_mozilla_page_load 05:07:29 INFO - PROCESS | 23668 | _x_x_mozilla_page_load_details 05:07:29 INFO - PROCESS | 23668 | |i|pagename|runs| 05:07:29 INFO - PROCESS | 23668 | |0;ai-astar;112;112;111;112;113;113;113;112;113;112 05:07:29 INFO - PROCESS | 23668 | |1;audio-beat-detection;150;119;130;165;122;120;123;120;145;127 05:07:29 INFO - PROCESS | 23668 | |2;audio-dft;161;164;162;160;160;161;162;161;162;161 05:07:29 INFO - PROCESS | 23668 | |3;audio-fft;74;75;76;113;78;75;75;76;105;75 05:07:29 INFO - PROCESS | 23668 | |4;audio-oscillator;84;84;113;84;85;84;98;85;84;103 05:07:29 INFO - PROCESS | 23668 | |5;imaging-gaussian-blur;127;127;127;127;127;127;128;127;127;126 05:07:29 INFO - PROCESS | 23668 | |6;imaging-darkroom;147;147;146;146;147;148;146;146;146;146 05:07:29 INFO - PROCESS | 23668 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;97;96 05:07:29 INFO - PROCESS | 23668 | |8;json-parse-financial;54;55;54;54;54;54;55;56;56;54 05:07:29 INFO - PROCESS | 23668 | |9;json-stringify-tinderbox;64;63;62;62;63;63;63;63;64;64 05:07:29 INFO - PROCESS | 23668 | |10;stanford-crypto-aes;90;83;86;88;79;80;80;80;83;80 05:07:29 INFO - PROCESS | 23668 | |11;stanford-crypto-ccm;134;126;127;134;126;124;125;140;167;125 05:07:29 INFO - PROCESS | 23668 | |12;stanford-crypto-pbkdf2;168;170;164;173;171;164;165;165;165;165 05:07:29 INFO - PROCESS | 23668 | |13;stanford-crypto-sha256-iterative;64;63;65;63;63;63;65;62;63;62 05:07:29 INFO - PROCESS | 23668 | __end_tp_report 05:07:29 INFO - PROCESS | 23668 | __start_cc_report 05:07:29 INFO - PROCESS | 23668 | _x_x_mozilla_cycle_collect,1657 05:07:29 INFO - PROCESS | 23668 | __end_cc_report 05:07:29 INFO - PROCESS | 23668 | __startTimestamp1481893649625__endTimestamp 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | ------- Summary: start ------- 05:07:29 INFO - PROCESS | 23668 | Number of tests: 14 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:07:29 INFO - PROCESS | 23668 | Values: 112.0 112.0 111.0 112.0 113.0 113.0 113.0 112.0 113.0 112.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:128.50 stddev:15.81 (12.3%) stddev-sans-first:15.38 05:07:29 INFO - PROCESS | 23668 | Values: 150.0 119.0 130.0 165.0 122.0 120.0 123.0 120.0 145.0 127.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 05:07:29 INFO - PROCESS | 23668 | Values: 161.0 164.0 162.0 160.0 160.0 161.0 162.0 161.0 162.0 161.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:14.29 (19.1%) stddev-sans-first:14.84 05:07:29 INFO - PROCESS | 23668 | Values: 74.0 75.0 76.0 113.0 78.0 75.0 75.0 76.0 105.0 75.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:84.00 stddev:10.49 (12.5%) stddev-sans-first:10.87 05:07:29 INFO - PROCESS | 23668 | Values: 84.0 84.0 113.0 84.0 85.0 84.0 98.0 85.0 84.0 103.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#5] imaging-gaussian-blur Cycles:10 Average:127.00 Median:127.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:07:29 INFO - PROCESS | 23668 | Values: 127.0 127.0 127.0 127.0 127.0 127.0 128.0 127.0 127.0 126.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 05:07:29 INFO - PROCESS | 23668 | Values: 147.0 147.0 146.0 146.0 147.0 148.0 146.0 146.0 146.0 146.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 05:07:29 INFO - PROCESS | 23668 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 97.0 96.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.87 05:07:29 INFO - PROCESS | 23668 | Values: 54.0 55.0 54.0 54.0 54.0 54.0 55.0 56.0 56.0 54.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 05:07:29 INFO - PROCESS | 23668 | Values: 64.0 63.0 62.0 62.0 63.0 63.0 63.0 63.0 64.0 64.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:3.87 (4.7%) stddev-sans-first:3.14 05:07:29 INFO - PROCESS | 23668 | Values: 90.0 83.0 86.0 88.0 79.0 80.0 80.0 80.0 83.0 80.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:130.50 stddev:13.12 (10.1%) stddev-sans-first:13.91 05:07:29 INFO - PROCESS | 23668 | Values: 134.0 126.0 127.0 134.0 126.0 124.0 125.0 140.0 167.0 125.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:166.50 stddev:3.27 (2.0%) stddev-sans-first:3.44 05:07:29 INFO - PROCESS | 23668 | Values: 168.0 170.0 164.0 173.0 171.0 164.0 165.0 165.0 165.0 165.0 05:07:29 INFO - PROCESS | 23668 | 05:07:29 INFO - PROCESS | 23668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.06 (1.7%) stddev-sans-first:1.09 05:07:29 INFO - PROCESS | 23668 | Values: 64.0 63.0 65.0 63.0 63.0 63.0 65.0 62.0 63.0 62.0 05:07:29 INFO - PROCESS | 23668 | -------- Summary: end -------- 05:07:29 INFO - PROCESS | 23668 | 05:07:30 INFO - TEST-INFO | 23668: exit 0 05:07:30 INFO - TEST-OK | kraken | took 61220ms 05:07:30 INFO - SUITE-END | took 1179s 05:07:30 INFO - Completed test suite (00:19:39) 05:07:30 INFO - javascript benchmark 05:07:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2997.970020299797, 3024.9697503024977, 3027.1372658792243, 3059.1434398368465, 3072.5237588173827, 5239.423663397033, 5273.630845840793, 5310.3893052298945, 5397.298351214342, 5419.729013549327, 5290.947090529094, 5307.230451584518, 5313.681179129255, 5368.221607866857, 5386.057439948013, 4805.735684537349, 4838.830640927577, 4839.927401088987, 4864.318995340655, 4918.606511479091, 4854.223324268118, 4920.68015578988, 4941.085899108676, 4976.4525902150735, 5001.8249361272365, 4890.706557606555, 4926.45808961014, 4958.281049247857, 4981.252812078181, 4999.125153098212, 4751.524847515256, 4788.449328327252, 4797.56821886032, 4827.613790896755, 4862.975685121587, 4834.975825120887, 4839.153148199086, 4861.781219845116, 4896.314515967767, 4913.950860491421, 5291.126964050927, 5363.356397232318, 5370.5435038021815, 5371.060064488699, 5371.355437347504, 5522.254495643077, 5551.666899986014, 5554.472325129106, 5668.291463567054, 5688.857778555528, 5642.210090587321, 5659.094544872801, 5685.403032681592, 5691.117876729114, 5722.170285308649, 5307.442718514539, 5311.123664595376, 5317.8404647860625, 5329.280547126088, 5332.146856502941, 5666.9716651416475, 5793.391693872167, 5801.7099145042575, 5805.332386775491, 5846.0646296593195, 5415.079436495806, 5523.6409633373705, 5544.750486228048, 5560.304961879765, 5561.860953476114, 5626.634268772516, 5673.234113394721, 5675.545956323567, 5680.0, 5718.228039214736, 5670.177824215466, 5671.773129074791, 5674.120511320752, 5676.517496012885, 5683.147527870769, 5323.0684630190335, 5379.0, 5395.298611180521, 5479.232907392969, 5735.369109397963, 4262.062346283875, 4264.978675106605, 4267.975685835439, 4270.380794784739, 4278.893027674333, 3808.0670235791854, 3869.400242962345, 3873.0, 3873.32216862048, 3874.7868867212574, 5266.894662106736, 5279.973600131974, 5282.445343238982, 5284.762185701653, 5285.260063591023, 5503.11950087984, 5512.724363781795, 5546.195801608744, 5548.667079975215, 5558.888822223533, 5398.0, 5414.133738601805, 5420.620556561003, 5424.240606315119, 5428.4028756836715, 4756.5956893664425, 4764.332993380929, 4782.593479554207, 4803.639727020487, 4810.7113573185725, 5871.55963302754, 5880.617759845596, 5886.676232807151, 5886.970565147147, 5887.499562537232, 5575.470330318613, 5623.634463759842, 5709.115087161496, 5712.485876271156, 5779.219805326227, 5898.970505147447, 5936.762529498945, 5951.315598706205, 5969.999999999826, 6005.489533389711, 5685.0335442973965, 5692.288463942007, 5705.144228365612, 5707.514861236841, 5712.371639119777, 5514.834554963358, 5820.912686309624, 5824.737886795189, 5826.417358264309, 5831.70841457917, 5420.566354691537, 5501.339839219319, 5533.225348451139, 5534.0, 5622.493975542221, 5570.6657600544095, 5576.804811831566, 5578.274824272981, 5587.525060369914, 5587.664740115606, 5476.589255805751, 5501.4223506532835, 5516.310461192351, 5516.862078448071, 5583.0, 5441.401445840876, 5449.863753406196, 5492.395836457907, 5519.806806761744, 5575.0, 5501.697406642513, 5547.5007249347755, 5593.888122237451, 5601.775928962796, 5603.859903502445], "value": 5231.103194027553, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.921566372876, 561.9438056194381, 569.8974184646762, 570.9914351284729, 580.5529742098587, 30821.537676934862, 41897.79051104744, 43599.34600980988, 43753.0, 43799.34300985488, 41098.0, 41642.79178604103, 41650.0, 41666.79166604163, 41681.791591042005, 8553.529555874424, 8735.21383075523, 8741.4755114693, 8743.0, 8757.737267881941, 7738.574378409186, 8076.676932922676, 10042.54808533614, 10323.174146068333, 10335.328203666737, 10318.432486213254, 10363.170946324275, 10379.065884070433, 10382.844257336146, 10384.06543411093, 10166.39001659899, 10220.488975551192, 10231.334963227366, 10238.84641730371, 10239.436830974293, 10065.396076235449, 10100.141487973531, 10115.645952391631, 10133.391996480235, 10143.543540540693, 39248.0, 39509.0, 39531.80234098811, 39542.802285988386, 39590.802045989585, 3185.856636451342, 3203.1191422358806, 3222.0817067135754, 3415.743819213544, 3520.6831385175456, 29629.555556666666, 29782.602242254627, 29859.70140298591, 30415.69584304173, 31314.530282045787, 4106.589341065899, 4182.184474027566, 4242.639375653073, 4251.44731184944, 4318.69769116162, 300355.0, 302665.0, 303041.0, 303492.0, 304765.4761726199, 55536.44463555393, 55967.0, 55968.0, 55987.0, 56021.43978560244, 52640.473595264324, 57668.71165644229, 58109.0, 58117.12824307639, 58253.70873145692, 16042.0, 16259.187040647921, 16274.186290685418, 16289.266982985793, 16296.0, 11330.773384532264, 11791.76416471683, 12713.618591442271, 12802.42389092493, 12803.359832008362, 15857.0, 16163.595910102107, 16342.918285408734, 16741.49775506737, 17009.659806803793, 5962.642241465526, 5973.641581505123, 5989.490893274121, 6031.095335699592, 6046.244219472566, 865.9567021648892, 934.4206591912922, 980.8773903262093, 1038.8337865941412, 1079.1528650009861, 29356.0, 30273.0, 30330.090097297118, 30946.53580196299, 30988.84505577458, 1001.7095042437758, 1038.6676263595577, 1102.459794700591, 1107.164091111222, 1133.0425790207262, 15126.0, 15453.613659658598, 16228.188590570424, 16270.0, 16682.332706691595, 512341.4382928136, 515238.0, 515310.0, 515746.0, 517122.0, 47117.528824712, 47151.05697886023, 47312.5268747315, 47329.0, 47360.526394735614, 1199.0827017331749, 1239.8264243005985, 1268.5623459906133, 1319.6502926724427, 1328.156620545941, 25499.107531236317, 27902.86048569744, 28486.287842804097, 28731.425371492034, 29395.706042940154, 46227.76886115548, 46752.29871551997, 46818.76590617025, 46881.0, 46956.530434696586, 392433.0, 397301.0, 397315.0, 397419.0, 397943.0, 24071.638925416482, 24287.907044182703, 24495.142670006466, 24664.50670986534, 25392.619110713724, 39938.2012359757, 39966.0, 40004.39993400043, 40641.0, 41069.1786164281, 34244.82877585596, 34786.782462613686, 34835.65164348324, 35216.64783352236, 35393.646063540065, 33772.831135844164, 33978.49032264567, 34099.48850767191, 34364.82817585896, 34454.0, 34216.65783342135, 35012.47481287732, 35181.82409087938, 35200.64799352076, 35434.0, 29354.70645293605, 32545.837270813496, 32668.346633067682, 32675.34649306953, 32737.508937366434, 24484.755152448248, 24981.375465613506, 25002.37494062663, 25487.2353829378, 25515.234542963743], "value": 18782.997111514298, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.8231202086938, 364.4878945082159, 372.10323121277725, 374.14321204441825, 390.3013605645894, 14024.158550486965, 17139.228734706936, 17447.38934137304, 17525.12374381279, 18291.359802406918, 17936.64126717468, 18042.18810153543, 18368.17343219555, 18377.908110459462, 18474.907625461852, 6017.75928962842, 6251.624902505841, 6286.559940804145, 6337.429631333179, 6415.0, 4530.569595888385, 4654.557817007379, 4718.716876987374, 6148.56960012797, 6198.194234749499, 7135.89296160558, 7156.85686286274, 7290.5625662460425, 7294.307040831139, 7295.270472952715, 6987.965060174666, 7127.501074924758, 7157.069580954495, 7168.856622867565, 7265.7456989005395, 6702.6648667566915, 6892.310768923117, 6919.723211071551, 6924.099867017306, 6941.236463988957, 24615.38461538458, 24991.250262492154, 25024.749752502423, 25034.123805666713, 25240.747592524207, 2370.668106465096, 2421.8183636227177, 2502.94994100117, 2682.28919336376, 2709.7290270972944, 15147.848521514754, 15237.390504379811, 15373.538793836204, 15520.844791552054, 15785.605359866095, 1960.7549056367955, 1984.7122167285663, 2063.123172651617, 2080.854340196187, 2139.5079131799616, 58784.706076469774, 68566.31433685649, 83625.58187209086, 84215.5789221056, 90830.54584727035, 16570.917145414194, 16742.832571674127, 17106.0, 17160.22778974949, 17353.132343382782, 29730.702692973227, 29848.25379365533, 29876.55185172224, 30000.549991749704, 30110.0, 9422.717318480456, 9433.952830235805, 9460.297146513694, 9784.266180036526, 10116.190704743603, 7730.497517661334, 7786.065672119382, 8006.239407256301, 8022.438429309892, 8073.475224110414, 8189.836203275901, 8443.704470343508, 8489.95755021221, 8670.95664521686, 8691.521966291915, 3174.7142757151505, 3271.4275001874576, 3272.541844141822, 3451.706604938558, 3466.9306613868084, 908.4957848394205, 929.3262384770987, 971.8299297623029, 1007.6120693533043, 1008.2236677758085, 17127.82872171287, 17973.191206395742, 18880.150393232336, 19343.129559169873, 20123.899380503004, 947.6351604632266, 965.232640051161, 985.8373368394134, 1008.6268080810147, 1086.3590481615884, 9996.650117246007, 10379.688609341732, 10500.579976800995, 10513.158947284199, 10533.36799792015, 450438.0, 453582.0, 454885.0, 456093.0, 457226.0, 82310.58844705738, 82406.58796705978, 84009.57995209986, 84225.57887210525, 86974.56512717396, 999.8200323941614, 1061.0874647802884, 1092.415557676639, 1093.792179485895, 1102.9669109926715, 16069.598260043593, 16362.590935226715, 16836.0, 16881.0, 17047.48857534276, 39881.401778973915, 40165.1966960665, 40495.508330958866, 41538.0, 41737.37393939154, 54928.72535637296, 55425.44574554203, 56528.717356412955, 56746.0, 57020.714896425256, 6413.807585772434, 7941.166177551274, 8112.1076681566165, 8187.426880118334, 8203.58982050907, 10490.737731556772, 12224.44989975471, 12337.383130843602, 12498.875011250135, 12568.748625027265, 10643.627473038407, 10810.837837432287, 11035.889641103486, 11090.390028548507, 11316.20786544934, 10804.891951080388, 10825.56697732082, 11129.888701113208, 11384.48769805344, 11607.535698571963, 10952.726181845517, 11297.209195356247, 11378.487968041292, 11473.139514536277, 11694.199385200014, 7100.0, 7947.0, 8032.0, 8119.431639785158, 8277.089520152898, 10613.787724245318, 11014.3942083183, 11190.552377904793, 11202.21584489078, 11598.88401115978], "value": 9921.068267941137, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.3326670131526, 1351.5945216435066, 1360.5578187089193, 1462.2469428244456, 1660.5350501859475, 6862.21084575274, 7496.362809161221, 7740.109887362955, 7760.068791744999, 8072.112067672551, 7837.490563113393, 7939.444238903265, 7941.642626081826, 7942.801429964254, 7945.721899733496, 1802.0629272778147, 1855.1466325490292, 2116.50262188386, 2142.753583337913, 2148.3018019143765, 2121.618108740426, 2190.321000489845, 2194.264921251383, 2194.7476040255337, 2196.077647388093, 2066.297458863986, 2085.2701554455894, 2085.384811480617, 2090.3833369156137, 2145.2598853395552, 2089.8014688604558, 2116.947076323089, 2117.428294360514, 2122.0450797141193, 2125.192426877792, 2064.349729835112, 2091.5712278982774, 2118.195085867376, 2119.98240844394, 2120.7349081364828, 7610.08678958523, 7646.732364367221, 7658.770236892902, 7667.693292268303, 7675.155732869436, 4581.633469322446, 4688.320193571947, 4694.319323698079, 4702.8118875244945, 4703.1064097821645, 2968.391479746647, 3088.3514461963014, 3114.065780265934, 3118.5322201669705, 3120.0951724000015, 945.3193700535672, 1007.5365331947313, 1032.1639472027682, 1039.3555995282898, 1051.5530899367739, 10435.582576696923, 10516.053555179995, 10532.578696852117, 10546.103581195608, 10549.261551691385, 3768.3593789055376, 4045.37296719009, 4069.89825254371, 4099.139180772071, 4107.219628270619, 8985.191332780081, 8991.910080899239, 8996.50519221436, 9004.50475223869, 9007.279417646572, 4726.125666751662, 4784.162771514971, 4807.230843065093, 4814.855554333376, 4815.061063092663, 3870.1098747288283, 3891.6302951220155, 4272.33778764292, 4393.956060439355, 4401.361802538614, 3395.6774106459848, 3447.3450044491465, 3492.5285086513504, 3495.7727747696317, 3506.2286297014616, 1133.5862410220375, 1144.8053830848776, 1149.4769879704713, 1163.5578480177478, 1172.0, 857.9785505362416, 876.5398165962921, 888.6045709659139, 918.2699753695828, 957.3346524165638, 5397.0, 5502.147167189092, 5521.643448213997, 5562.16567514876, 5605.159226116115, 874.9956250218709, 892.0041382655987, 907.9921287371013, 933.4912472702258, 951.8619800129081, 3710.239400922804, 3879.8060096995036, 3891.280113179071, 4003.4195041718785, 4007.499062617173, 9227.354085214105, 9552.95223523878, 9608.423494590346, 9614.95192524033, 9642.951785241028, 9508.429494230368, 9509.33434659581, 9513.904860951441, 9552.808943821085, 9554.283428742872, 7242.298059955906, 7398.630068496554, 7409.147947985943, 7411.443596844723, 7427.591482468516, 5194.441807361969, 5327.493888080626, 5430.51125398716, 5504.504594586507, 5672.290963629546, 8351.791205219919, 8632.654693812428, 8644.308455323684, 8807.51558664254, 8839.69061082859, 8523.190296921783, 8839.337049721426, 8839.734807955772, 8849.469031858109, 8963.910360896307, 6203.658798766111, 6351.618902865843, 6874.621895795779, 6939.167299924042, 7107.75122870697, 7416.44376671741, 7550.093988721389, 7556.206598307099, 7581.3176814087, 7585.810354741176, 6777.356151165632, 6864.112369098538, 6880.449564034765, 6888.41448476885, 6987.615681137586, 6686.398224159654, 6747.831304217238, 6777.695003724745, 6814.318568143344, 6819.829504262235, 6306.243250809932, 6329.113924050729, 6355.269144048493, 6370.617762934239, 6449.645269510222, 4632.953670463387, 4655.767211639472, 4699.953000469952, 4719.929201062056, 4834.685745426536, 4887.535684110004, 4923.8276660316715, 4936.851894443173, 4946.851594452172, 4978.303037574815], "value": 4164.777981542294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.7499737682312, 361.925805209932, 363.8671884762062, 367.53873888270226, 373.4920508108973, 5072.898542029157, 5152.943646552457, 5190.14362630166, 5199.194124910645, 5209.661372010822, 5052.736815796051, 5092.643514953955, 5113.923291150636, 5190.520701600045, 5237.3453318335205, 3995.7802320872343, 4093.488313960755, 4158.8336466541305, 4163.583641635827, 4176.164767046595, 4018.63832255097, 4143.97928010361, 4148.274052040896, 4149.481314835631, 4153.7507749535125, 4099.590040995891, 4117.135401565675, 4132.0, 4141.337386018237, 4145.129522800215, 4110.17796440713, 4114.855980040684, 4120.58794120587, 4131.624316018301, 4187.769672668002, 3393.9151521212166, 3528.153243221634, 3529.6058057067316, 3539.610642829287, 3564.590072141685, 4965.652404331699, 5016.3227964224725, 5023.2214006829, 5032.547070763649, 5045.949540504622, 4511.255657804048, 4547.1360441516335, 4583.381243532114, 4597.149527337453, 4599.0, 5139.922901156486, 5265.445824068738, 5315.548178404841, 5326.9612425577025, 5337.973310133424, 3838.2323535293053, 3862.613738626143, 3865.922681546381, 3886.591907849663, 3910.8658489038144, 5599.720013999325, 5607.747651355739, 5618.101103823409, 5646.858828529279, 5649.887002259973, 3790.962090379116, 3921.8039098044983, 3961.8613348532663, 3982.203559288154, 3986.5814089520763, 3977.880663580097, 3993.4209539617173, 3994.201159768, 4000.819963101609, 4012.25773231953, 4562.703424277412, 4568.931466028012, 4584.0, 4618.838340658061, 4632.143053535106, 5208.7916483341, 5310.247618285956, 5334.0, 5394.406615272317, 5466.753996070186, 1336.1048097774515, 1337.7926421404698, 1342.825432693763, 1344.6571124363224, 1350.2236214176692, 856.905740368559, 891.3893982621925, 893.8659201119884, 895.4135041547796, 905.968291109808, 5132.409772876093, 5145.507802737239, 5150.175971844562, 5185.818496352609, 5206.73966301691, 5396.217548455452, 5399.865003374868, 5439.0, 5491.780328786804, 5502.504774570308, 5114.462981386975, 5177.508136727005, 5186.481351864783, 5215.478452154754, 5396.541293989976, 2893.392387598628, 2909.898153564615, 2911.505044142501, 2941.3970136122043, 2941.4557357387544, 5599.8600034998635, 5628.352739435018, 5636.774529018793, 5654.830355089354, 5670.376258611549, 5422.8373148805595, 5452.809151679672, 5464.316960379952, 5509.531689806331, 5532.972335138298, 5532.640378375393, 5543.916841247304, 5549.667019978814, 5549.916751248735, 5593.636413633101, 5301.602379821452, 5387.111126664213, 5428.91856622143, 5441.972790136182, 5479.424660410599, 5529.391766905717, 5543.695096769717, 5545.2513910623165, 5555.694436805853, 5569.916451253153, 5769.451902069297, 5778.595498315078, 5794.783095549982, 5813.331466881363, 5848.0, 3857.5756666767193, 3912.7065470089287, 3921.392184211452, 3933.213357328603, 3955.4066889966734, 5349.732513374238, 5483.4516548344845, 5606.85982850432, 5613.410591887793, 5623.775048997994, 5370.275012873212, 5458.399576046552, 5492.890142197213, 5498.477644623755, 5499.807506737245, 5475.4524547544925, 5478.315210598676, 5489.862753431196, 5505.201745746765, 5511.751971161388, 5213.800825810009, 5345.9150931137665, 5422.728863556886, 5435.271313956883, 5457.426970168075, 5489.780408783604, 5509.559235261089, 5525.585581081355, 5527.44725527444, 5539.307586551681, 5227.268182454535, 5380.542653874464, 5406.594505412031, 5444.646098003617, 5458.4541545845095], "value": 4137.143267296571, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.1731613405847, 736.8231624410143, 741.2291217134181, 762.3481922955873, 809.8906647602573, 14787.0, 14990.0, 15100.093994360346, 15206.771898421519, 15842.28709708063, 13362.131461455, 13669.453221871137, 13786.379612917417, 13834.377453014613, 13949.372278247478, 665.9001149827516, 774.0401901641966, 791.8574656561816, 794.8966634337557, 795.1928792275816, 682.0519477925687, 690.6650274616807, 690.8445599740069, 770.1335997003371, 781.6873250699737, 822.9135940726227, 828.5857071464268, 828.8052307707713, 828.8508068547659, 829.1128492513013, 820.9343252539842, 825.7275099217244, 825.8719898415756, 826.4710585225461, 826.4834478450969, 507.6294305157256, 525.6005435868767, 527.9260903473516, 605.966671833049, 606.5147881694671, 11010.559577616887, 13226.404811783494, 13797.310134493235, 13829.170249785046, 14366.640833979234, 14674.413023479048, 14688.796680498011, 14883.925580372028, 15034.248287585686, 15080.472183473526, 11594.188406811527, 11693.88306116945, 11772.0, 11964.760704785942, 12158.817617735742, 3674.577423596267, 3758.774473531597, 3779.433085037239, 3871.9612803871883, 3874.5156855393075, 74535.25464745337, 74638.62680686616, 75032.0, 75048.62475687641, 75065.0, 10420.583176673, 10584.57661693539, 10717.83923241152, 10945.507452164671, 11346.205765596329, 21044.47388815292, 21214.46963825917, 21438.464038399165, 21694.674579881314, 21872.23447179373, 7523.285287897641, 7667.53994760305, 7992.840143197103, 8028.879566806502, 8215.383846211438, 4381.759003254851, 4466.57567531084, 4486.955130448654, 4497.482789479186, 4539.659525535598, 3175.079227024183, 3269.3134441767497, 3281.9835900820344, 3297.1427428868187, 3326.86692532296, 519.7713006277226, 532.4515748778764, 535.1117145538387, 538.251829956361, 545.1033050631768, 589.7523040323075, 659.9538032337787, 692.1693967239232, 694.979150625482, 714.6069661686051, 8440.198181172902, 9129.680461183827, 9318.813623727623, 9450.196733277748, 9597.520123993912, 640.7917426836296, 652.4943169043934, 673.8989151627295, 684.7295318349225, 704.7842471736215, 4221.0, 4839.201531747222, 5064.316317297118, 5174.793008279702, 5260.105782017066, 71647.0, 71805.64097179481, 73562.0, 74714.25285747182, 79339.0, 64166.0, 64419.35580644134, 65770.0, 66793.0, 66956.33043669598, 58391.12413313804, 60493.69753151206, 60813.391866080776, 61082.694586526784, 62631.6868415655, 9068.183863452321, 9307.441553506811, 9319.347645664739, 9343.159115679622, 9545.236381089635, 41522.0, 42376.364354535326, 42760.78619607007, 42868.78565607152, 43991.78004109959, 52845.735771322434, 56929.71535142298, 57389.42610573841, 57563.71218143882, 59419.40580594139, 12638.2417054977, 13023.934880325538, 13069.346532673519, 13533.052686311863, 13786.724265514835, 13401.86598134006, 13403.865961340261, 13794.784061747732, 13978.252718410198, 14326.0, 12560.685982850502, 13063.542776002794, 13351.866481335452, 13703.931480342535, 14139.787903181255, 13120.868791312347, 13163.144395614254, 13297.800532992207, 13338.733225335245, 13382.330883455594, 12403.0, 13129.015323850941, 13371.130876492996, 13489.39297731624, 13493.190408575125, 10347.689569312932, 10418.238412382823, 10720.785584288427, 10942.17933654995, 10970.506327215455, 10862.782744344911, 11285.272689322068, 11675.824862626898, 11709.941450292694, 11749.353785541878], "value": 6963.608165161339, "unit": "score"}], "name": "dromaeo_css", "value": 6993.2981692311805, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 111.0, 112.0, 113.0, 113.0, 113.0, 112.0, 113.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 130.0, 165.0, 122.0, 120.0, 123.0, 120.0, 145.0, 127.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 162.0, 160.0, 160.0, 161.0, 162.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 113.0, 78.0, 75.0, 75.0, 76.0, 105.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 84.0, 85.0, 84.0, 98.0, 85.0, 84.0, 103.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 128.0, 127.0, 127.0, 126.0], "value": 127.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 97.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 56.0, 56.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 86.0, 88.0, 79.0, 80.0, 80.0, 80.0, 83.0, 80.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 126.0, 127.0, 134.0, 126.0, 124.0, 125.0, 140.0, 167.0, 125.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 164.0, 173.0, 171.0, 164.0, 165.0, 165.0, 165.0, 165.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 63.0, 63.0, 65.0, 62.0, 63.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1511.0, "alertThreshold": 2.0}]} 05:07:30 INFO - Return code: 0 05:07:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:30 INFO - # TBPL SUCCESS # 05:07:30 INFO - Running post-action listener: _resource_record_post_action 05:07:30 INFO - [mozharness: 2016-12-16 13:07:30.925271Z] Finished run-tests step (success) 05:07:30 INFO - Running post-run listener: _resource_record_post_run 05:07:31 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 395337728; Read time: 16; Write time: 246608 05:07:31 INFO - TinderboxPrint: CPU usage
13.1% 05:07:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:07:31 INFO - TinderboxPrint: I/O write bytes / time
395,337,728 / 246,608 05:07:31 INFO - TinderboxPrint: CPU idle
8,298.7 (86.9%) 05:07:31 INFO - TinderboxPrint: CPU user
1,210.3 (12.7%) 05:07:31 INFO - TinderboxPrint: Swap in / out
0 / 0 05:07:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104026112; Read time: 0; Write time: 81864 05:07:31 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 291311616; Read time: 0; Write time: 164744 05:07:31 INFO - Running post-run listener: _upload_blobber_files 05:07:31 INFO - Blob upload gear active. 05:07:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:07:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:07:31 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:32 INFO - (blobuploader) - INFO - Done attempting. 05:07:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:35 INFO - (blobuploader) - INFO - Done attempting. 05:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:36 INFO - (blobuploader) - INFO - Done attempting. 05:07:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:36 INFO - Return code: 0 05:07:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35c3402e107028fbc1ef35a60917e33cb743d27ca923c57b34e19c3cfb562d5b40f0b0a7bcf1bff1e3707d6d467810de8b6fe891b4426839b58dfde971801658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e4a2811451430242f5fff47d1f34daf020b6da1605a27a4699891bbe31cb929cf7518defc562ceac4b8b634369c71e72c483c4d2dd8fa548bf279be19e47b83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28469695be4b4f50a3b301ad8806ebcdc7917f6a1f830a831fcb08dee8d7a2c1493baea61182ff894cf252e71f11bf12d97458c713a87d6d11a679ade299f1bd"} 05:07:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:36 INFO - Contents: 05:07:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35c3402e107028fbc1ef35a60917e33cb743d27ca923c57b34e19c3cfb562d5b40f0b0a7bcf1bff1e3707d6d467810de8b6fe891b4426839b58dfde971801658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e4a2811451430242f5fff47d1f34daf020b6da1605a27a4699891bbe31cb929cf7518defc562ceac4b8b634369c71e72c483c4d2dd8fa548bf279be19e47b83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28469695be4b4f50a3b301ad8806ebcdc7917f6a1f830a831fcb08dee8d7a2c1493baea61182ff894cf252e71f11bf12d97458c713a87d6d11a679ade299f1bd"} 05:07:36 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:36 INFO - Copying logs to upload dir... 05:07:36 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.480916 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-12-16 05:07:36.302362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 05:07:36.306068) ========= 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=cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498 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/35c3402e107028fbc1ef35a60917e33cb743d27ca923c57b34e19c3cfb562d5b40f0b0a7bcf1bff1e3707d6d467810de8b6fe891b4426839b58dfde971801658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e4a2811451430242f5fff47d1f34daf020b6da1605a27a4699891bbe31cb929cf7518defc562ceac4b8b634369c71e72c483c4d2dd8fa548bf279be19e47b83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28469695be4b4f50a3b301ad8806ebcdc7917f6a1f830a831fcb08dee8d7a2c1493baea61182ff894cf252e71f11bf12d97458c713a87d6d11a679ade299f1bd"} build_url:https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/Z0yyGtrRTI2uWgKHdA2USA/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/35c3402e107028fbc1ef35a60917e33cb743d27ca923c57b34e19c3cfb562d5b40f0b0a7bcf1bff1e3707d6d467810de8b6fe891b4426839b58dfde971801658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e4a2811451430242f5fff47d1f34daf020b6da1605a27a4699891bbe31cb929cf7518defc562ceac4b8b634369c71e72c483c4d2dd8fa548bf279be19e47b83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28469695be4b4f50a3b301ad8806ebcdc7917f6a1f830a831fcb08dee8d7a2c1493baea61182ff894cf252e71f11bf12d97458c713a87d6d11a679ade299f1bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 05:07:36.331266) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 05:07:36.331608) ========= 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=cbe409c6de289db6ac707de3000001d4-1481892305.317963-469488498 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 05:07:36.417422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 05:07:36.417752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 05:07:36.418046) ========= ========= Total master_lag: 0.17 =========