builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1480856033.22 results: success (0) buildid: 20161204030210 builduid: 8e7439266c2c429b8687ad68da5ea344 revision: 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:53.221534) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:53.222386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:53.223028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:53.240814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:53.241086) ========= 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=62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-04 04:53: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% 222M=0s 2016-12-04 04:53:54 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128149 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:53.382400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:53.382681) ========= 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=62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017013 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:53.432467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-04 04:53:53.432804) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 --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 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 --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=62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-04 04:53:54,127 truncating revision to first 12 chars 2016-12-04 04:53:54,127 Setting DEBUG logging. 2016-12-04 04:53:54,127 attempt 1/10 2016-12-04 04:53:54,127 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6bdef7ba8b41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-04 04:53:55,102 unpacking tar archive at: mozilla-central-6bdef7ba8b41/testing/mozharness/ program finished with exit code 0 elapsedTime=1.281761 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-04 04:53:54.728165) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:54.728548) ========= script_repo_revision: 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:54.728962) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:54.729277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-04 04:53:54.740182) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-12-04 04:53:54.740489) ========= /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=62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:53:55 INFO - MultiFileLogger online at 20161204 04:53:55 in /builds/slave/test 04:53:55 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:53:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:53:55 INFO - {'append_to_log': False, 04:53:55 INFO - 'base_work_dir': '/builds/slave/test', 04:53:55 INFO - 'blob_upload_branch': 'Firefox', 04:53:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:53:55 INFO - 'branch': 'Firefox', 04:53:55 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:55 INFO - 'config_files': ('talos/linux_config.py',), 04:53:55 INFO - 'default_actions': ('clobber', 04:53:55 INFO - 'read-buildbot-config', 04:53:55 INFO - 'download-and-extract', 04:53:55 INFO - 'populate-webroot', 04:53:55 INFO - 'create-virtualenv', 04:53:55 INFO - 'install', 04:53:55 INFO - 'run-tests'), 04:53:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:55 INFO - 'download_minidump_stackwalk': True, 04:53:55 INFO - 'download_symbols': 'ondemand', 04:53:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:55 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:55 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:55 INFO - 'installer_path': 'installer.exe', 04:53:55 INFO - 'log_level': 'info', 04:53:55 INFO - 'log_name': 'talos', 04:53:55 INFO - 'log_to_console': True, 04:53:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:53:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:53:55 INFO - 'opt_config_files': (), 04:53:55 INFO - 'pip_index': False, 04:53:55 INFO - 'sps_profile': False, 04:53:55 INFO - 'sps_profile_interval': 0, 04:53:55 INFO - 'suite': 'dromaeojs', 04:53:55 INFO - 'system_bits': '32', 04:53:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:55 INFO - 'title': 'talos-linux64-ix-018', 04:53:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:55 INFO - 'use_talos_json': True, 04:53:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:53:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:55 INFO - 'work_dir': 'build'} 04:53:55 INFO - [mozharness: 2016-12-04 12:53:55.529368Z] Running clobber step. 04:53:55 INFO - Running pre-action listener: _resource_record_pre_action 04:53:55 INFO - Running main action method: clobber 04:53:55 INFO - rmtree: /builds/slave/test/build 04:53:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:53:56 INFO - Running post-action listener: _resource_record_post_action 04:53:56 INFO - [mozharness: 2016-12-04 12:53:56.500048Z] Finished clobber step (success) 04:53:56 INFO - [mozharness: 2016-12-04 12:53:56.500146Z] Running read-buildbot-config step. 04:53:56 INFO - Running pre-action listener: _resource_record_pre_action 04:53:56 INFO - Running main action method: read_buildbot_config 04:53:56 INFO - Using buildbot properties: 04:53:56 INFO - { 04:53:56 INFO - "project": "", 04:53:56 INFO - "product": "firefox", 04:53:56 INFO - "script_repo_revision": "production", 04:53:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:53:56 INFO - "repository": "", 04:53:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:53:56 INFO - "buildid": "20161204030210", 04:53:56 INFO - "stage_platform": "linux64-pgo", 04:53:56 INFO - "basedir": "/builds/slave/test", 04:53:56 INFO - "nightly_build": "True", 04:53:56 INFO - "buildnumber": 94, 04:53:56 INFO - "slavename": "talos-linux64-ix-018", 04:53:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:53:56 INFO - "platform": "ubuntu64_hw", 04:53:56 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:53:56 INFO - "branch": "mozilla-central", 04:53:56 INFO - "repo_path": "mozilla-central", 04:53:56 INFO - "revision": "6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017", 04:53:56 INFO - "pgo_build": "True", 04:53:56 INFO - "builduid": "8e7439266c2c429b8687ad68da5ea344", 04:53:56 INFO - "slavebuilddir": "test" 04:53:56 INFO - } 04:53:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 04:53:56 INFO - Running post-action listener: _resource_record_post_action 04:53:56 INFO - [mozharness: 2016-12-04 12:53:56.502643Z] Finished read-buildbot-config step (success) 04:53:56 INFO - [mozharness: 2016-12-04 12:53:56.502732Z] Running download-and-extract step. 04:53:56 INFO - Running pre-action listener: _resource_record_pre_action 04:53:56 INFO - Running main action method: download_and_extract 04:53:56 INFO - mkdir: /builds/slave/test/build/tests 04:53:56 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:53:56 INFO - trying https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:53:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/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:53:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/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:53:57 INFO - Downloaded 1361 bytes. 04:53:57 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:53:57 INFO - Using the following test package requirements: 04:53:57 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:57 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:53:57 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:53:57 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:57 INFO - u'jsshell-linux-x86_64.zip'], 04:53:57 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:53:57 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:57 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:53:57 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:53:57 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:53:57 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:53:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:53:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:53:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:53:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:53:57 INFO - Expected file size: 21780695 04:53:57 INFO - Obtained file size: 21780695 04:54:02 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:54:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:54:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:54:02 INFO - Fetch https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:54:02 INFO - Expected file size: 21780695 04:54:02 INFO - Obtained file size: 21780695 04:54:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:54:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:54:08 INFO - Expected file size: 14409734 04:54:08 INFO - Obtained file size: 14409734 04:54: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:54:08 INFO - trying https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:54:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/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:54:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/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:54:10 INFO - Downloaded 59834143 bytes. 04:54:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:54:10 INFO - mkdir: /builds/slave/test/properties 04:54:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:54:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:54:10 INFO - Contents: 04:54:10 INFO - build_url:https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:54:11 INFO - Running post-action listener: _resource_record_post_action 04:54:11 INFO - Running post-action listener: set_extra_try_arguments 04:54:11 INFO - [mozharness: 2016-12-04 12:54:11.658178Z] Finished download-and-extract step (success) 04:54:11 INFO - [mozharness: 2016-12-04 12:54:11.658404Z] Running populate-webroot step. 04:54:11 INFO - Running pre-action listener: _resource_record_pre_action 04:54:11 INFO - Running main action method: populate_webroot 04:54:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:11 INFO - '--tppagecycles', 04:54:11 INFO - '7'], 04:54:11 INFO - 'tests': ['tsvgm']}}, 04:54:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:54:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:54:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:54:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['damp', 'tps']}, 04:54:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'tests': ['damp', 'tps']}, 04:54:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['dromaeo_dom']}, 04:54:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['basic_compositor_video']}, 04:54:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:54:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['a11yr', 04:54:11 INFO - 'ts_paint', 04:54:11 INFO - 'tpaint', 04:54:11 INFO - 'sessionrestore', 04:54:11 INFO - 'sessionrestore_no_auto_restore', 04:54:11 INFO - 'tabpaint']}, 04:54:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['tsvgx', 04:54:11 INFO - 'tsvgr_opacity', 04:54:11 INFO - 'tart', 04:54:11 INFO - 'tscrollx', 04:54:11 INFO - 'cart', 04:54:11 INFO - 'tsvg_static']}, 04:54:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:54:11 INFO - 'tsvgr_opacity', 04:54:11 INFO - 'tart', 04:54:11 INFO - 'tscrollx', 04:54:11 INFO - 'cart', 04:54:11 INFO - 'tsvg_static']}, 04:54:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'talos_options': ['--disable-e10s'], 04:54:11 INFO - 'tests': ['tp5o']}, 04:54:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:54:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'talos_options': ['--disable-e10s', 04:54:11 INFO - '--xperf_path', 04:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:11 INFO - 'tests': ['tp5n']}, 04:54:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:54:11 INFO - 'talos_options': ['--xperf_path', 04:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:11 INFO - 'tests': ['tp5n']}}, 04:54:11 INFO - 'talos.zip': {'path': '', 04:54:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:11 INFO - Running post-action listener: _resource_record_post_action 04:54:11 INFO - [mozharness: 2016-12-04 12:54:11.675594Z] Finished populate-webroot step (success) 04:54:11 INFO - [mozharness: 2016-12-04 12:54:11.675682Z] Running create-virtualenv step. 04:54:11 INFO - Running pre-action listener: _resource_record_pre_action 04:54:11 INFO - Running main action method: create_virtualenv 04:54:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:54: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:54:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:54:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:11 INFO - Using real prefix '/usr' 04:54:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:54:12 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:14 INFO - Installing pip.................done. 04:54:14 INFO - Return code: 0 04:54:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:54:14 INFO - Reading from file tmpfile_stdout 04:54:14 INFO - Output received: 04:54: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:54:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:54: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:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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 0x7fbc2d1ace30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, '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': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', '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:54: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:54: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:54:14 INFO - Using env: {'DISPLAY': ':0', 04:54:14 INFO - 'HOME': '/home/cltbld', 04:54:14 INFO - 'LANG': 'en_US.UTF-8', 04:54:14 INFO - 'LANGUAGE': 'en_US:en', 04:54:14 INFO - 'LOGNAME': 'cltbld', 04:54:14 INFO - 'MAIL': '/var/mail/cltbld', 04:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:14 INFO - 'MOZ_NO_REMOTE': '1', 04:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:14 INFO - 'NO_EM_RESTART': '1', 04:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:14 INFO - 'PWD': '/builds/slave/test', 04:54:14 INFO - 'SHELL': '/bin/bash', 04:54:14 INFO - 'SHLVL': '1', 04:54:14 INFO - 'TERM': 'linux', 04:54:14 INFO - 'TMOUT': '86400', 04:54:14 INFO - 'USER': 'cltbld', 04:54:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:14 INFO - '_': '/tools/buildbot/bin/python'} 04:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54: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:54:14 INFO - Cleaning up... 04:54:14 INFO - Return code: 0 04:54:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:54: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:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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 0x7fbc2d1ace30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, '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': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', '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:54: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:54: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:54:14 INFO - Using env: {'DISPLAY': ':0', 04:54:14 INFO - 'HOME': '/home/cltbld', 04:54:14 INFO - 'LANG': 'en_US.UTF-8', 04:54:14 INFO - 'LANGUAGE': 'en_US:en', 04:54:14 INFO - 'LOGNAME': 'cltbld', 04:54:14 INFO - 'MAIL': '/var/mail/cltbld', 04:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:14 INFO - 'MOZ_NO_REMOTE': '1', 04:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:14 INFO - 'NO_EM_RESTART': '1', 04:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:14 INFO - 'PWD': '/builds/slave/test', 04:54:14 INFO - 'SHELL': '/bin/bash', 04:54:14 INFO - 'SHLVL': '1', 04:54:14 INFO - 'TERM': 'linux', 04:54:14 INFO - 'TMOUT': '86400', 04:54:14 INFO - 'USER': 'cltbld', 04:54:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:14 INFO - '_': '/tools/buildbot/bin/python'} 04:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:14 INFO - Downloading/unpacking psutil>=3.1.1 04:54: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:54: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:54: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:54: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:54: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:54: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:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:16 INFO - Installing collected packages: psutil 04:54:16 INFO - Running setup.py install for psutil 04:54:17 INFO - building 'psutil._psutil_linux' extension 04:54:17 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:54: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:54:17 INFO - building 'psutil._psutil_posix' extension 04:54:17 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:54: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:54:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:17 INFO - Successfully installed psutil 04:54:17 INFO - Cleaning up... 04:54:17 INFO - Return code: 0 04:54:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:54: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:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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 0x7fbc2d1ace30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, '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': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', '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:54: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:54: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:54:17 INFO - Using env: {'DISPLAY': ':0', 04:54:17 INFO - 'HOME': '/home/cltbld', 04:54:17 INFO - 'LANG': 'en_US.UTF-8', 04:54:17 INFO - 'LANGUAGE': 'en_US:en', 04:54:17 INFO - 'LOGNAME': 'cltbld', 04:54:17 INFO - 'MAIL': '/var/mail/cltbld', 04:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:17 INFO - 'MOZ_NO_REMOTE': '1', 04:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:17 INFO - 'NO_EM_RESTART': '1', 04:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:17 INFO - 'PWD': '/builds/slave/test', 04:54:17 INFO - 'SHELL': '/bin/bash', 04:54:17 INFO - 'SHLVL': '1', 04:54:17 INFO - 'TERM': 'linux', 04:54:17 INFO - 'TMOUT': '86400', 04:54:17 INFO - 'USER': 'cltbld', 04:54:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:17 INFO - '_': '/tools/buildbot/bin/python'} 04:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:54: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:54: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:54: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:54: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:54: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:54: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:54:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54: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:54:19 INFO - Installing collected packages: mozsystemmonitor 04:54:19 INFO - Running setup.py install for mozsystemmonitor 04:54:19 INFO - Successfully installed mozsystemmonitor 04:54:19 INFO - Cleaning up... 04:54:19 INFO - Return code: 0 04:54:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:54: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:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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 0x7fbc2d1ace30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, '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': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', '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:54: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:54: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:54:19 INFO - Using env: {'DISPLAY': ':0', 04:54:19 INFO - 'HOME': '/home/cltbld', 04:54:19 INFO - 'LANG': 'en_US.UTF-8', 04:54:19 INFO - 'LANGUAGE': 'en_US:en', 04:54:19 INFO - 'LOGNAME': 'cltbld', 04:54:19 INFO - 'MAIL': '/var/mail/cltbld', 04:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:19 INFO - 'MOZ_NO_REMOTE': '1', 04:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:19 INFO - 'NO_EM_RESTART': '1', 04:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:19 INFO - 'PWD': '/builds/slave/test', 04:54:19 INFO - 'SHELL': '/bin/bash', 04:54:19 INFO - 'SHLVL': '1', 04:54:19 INFO - 'TERM': 'linux', 04:54:19 INFO - 'TMOUT': '86400', 04:54:19 INFO - 'USER': 'cltbld', 04:54:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:19 INFO - '_': '/tools/buildbot/bin/python'} 04:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:20 INFO - Downloading/unpacking jsonschema==2.5.1 04:54:20 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:54:20 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:54:20 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:54:20 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:54:20 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:54:20 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:54:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:54: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:54: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:54: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:54: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:54: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:54: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:54:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:54:22 INFO - warning: no files found matching '*.txt' 04:54:22 INFO - no previously-included directories found matching 'build' 04:54:22 INFO - no previously-included directories found matching 'dist' 04:54:22 INFO - no previously-included directories found matching '.git*' 04:54:22 INFO - Installing collected packages: jsonschema, functools32 04:54:22 INFO - Running setup.py install for functools32 04:54:22 INFO - warning: no files found matching '*.txt' 04:54:22 INFO - no previously-included directories found matching 'build' 04:54:22 INFO - no previously-included directories found matching 'dist' 04:54:22 INFO - no previously-included directories found matching '.git*' 04:54:22 INFO - Successfully installed jsonschema functools32 04:54:22 INFO - Cleaning up... 04:54:22 INFO - Return code: 0 04:54:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:54: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:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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 0x7fbc2d1ace30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, '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': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', '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:54: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:54: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:54:22 INFO - Using env: {'DISPLAY': ':0', 04:54:22 INFO - 'HOME': '/home/cltbld', 04:54:22 INFO - 'LANG': 'en_US.UTF-8', 04:54:22 INFO - 'LANGUAGE': 'en_US:en', 04:54:22 INFO - 'LOGNAME': 'cltbld', 04:54:22 INFO - 'MAIL': '/var/mail/cltbld', 04:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:22 INFO - 'MOZ_NO_REMOTE': '1', 04:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:22 INFO - 'NO_EM_RESTART': '1', 04:54:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:22 INFO - 'PWD': '/builds/slave/test', 04:54:22 INFO - 'SHELL': '/bin/bash', 04:54:22 INFO - 'SHLVL': '1', 04:54:22 INFO - 'TERM': 'linux', 04:54:22 INFO - 'TMOUT': '86400', 04:54:22 INFO - 'USER': 'cltbld', 04:54:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:22 INFO - '_': '/tools/buildbot/bin/python'} 04:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:54:22 INFO - Cleaning up... 04:54:22 INFO - Return code: 0 04:54:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:54: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:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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 0x7fbc2d1ace30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, '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': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', '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:54: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:54: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:54:22 INFO - Using env: {'DISPLAY': ':0', 04:54:22 INFO - 'HOME': '/home/cltbld', 04:54:22 INFO - 'LANG': 'en_US.UTF-8', 04:54:22 INFO - 'LANGUAGE': 'en_US:en', 04:54:22 INFO - 'LOGNAME': 'cltbld', 04:54:22 INFO - 'MAIL': '/var/mail/cltbld', 04:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:22 INFO - 'MOZ_NO_REMOTE': '1', 04:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:22 INFO - 'NO_EM_RESTART': '1', 04:54:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:22 INFO - 'PWD': '/builds/slave/test', 04:54:22 INFO - 'SHELL': '/bin/bash', 04:54:22 INFO - 'SHLVL': '1', 04:54:22 INFO - 'TERM': 'linux', 04:54:22 INFO - 'TMOUT': '86400', 04:54:22 INFO - 'USER': 'cltbld', 04:54:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:22 INFO - '_': '/tools/buildbot/bin/python'} 04:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:23 INFO - Downloading/unpacking blobuploader==1.2.4 04:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:24 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54: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:54: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:54: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:54: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:54: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:54: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:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:54:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54: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:54: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:54: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:54: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:54: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:54: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:54:25 INFO - Downloading docopt-0.6.1.tar.gz 04:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:54:25 INFO - Installing collected packages: blobuploader, requests, docopt 04:54:25 INFO - Running setup.py install for blobuploader 04:54:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:54:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:54:25 INFO - Running setup.py install for requests 04:54:26 INFO - Running setup.py install for docopt 04:54:26 INFO - Successfully installed blobuploader requests docopt 04:54:26 INFO - Cleaning up... 04:54:26 INFO - Return code: 0 04:54:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54: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:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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 0x7fbc2d1ace30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, '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': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', '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:54: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:54: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:54:26 INFO - Using env: {'DISPLAY': ':0', 04:54:26 INFO - 'HOME': '/home/cltbld', 04:54:26 INFO - 'LANG': 'en_US.UTF-8', 04:54:26 INFO - 'LANGUAGE': 'en_US:en', 04:54:26 INFO - 'LOGNAME': 'cltbld', 04:54:26 INFO - 'MAIL': '/var/mail/cltbld', 04:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:26 INFO - 'MOZ_NO_REMOTE': '1', 04:54:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:26 INFO - 'NO_EM_RESTART': '1', 04:54:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:26 INFO - 'PWD': '/builds/slave/test', 04:54:26 INFO - 'SHELL': '/bin/bash', 04:54:26 INFO - 'SHLVL': '1', 04:54:26 INFO - 'TERM': 'linux', 04:54:26 INFO - 'TMOUT': '86400', 04:54:26 INFO - 'USER': 'cltbld', 04:54:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:26 INFO - '_': '/tools/buildbot/bin/python'} 04:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:26 INFO - Running setup.py (path:/tmp/pip-K3D7wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:26 INFO - Running setup.py (path:/tmp/pip-wTGJpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:26 INFO - Running setup.py (path:/tmp/pip-G97aWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:26 INFO - Running setup.py (path:/tmp/pip-haAJST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:26 INFO - Running setup.py (path:/tmp/pip-g0lBNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:26 INFO - Running setup.py (path:/tmp/pip-K3cxqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:27 INFO - Running setup.py (path:/tmp/pip-Da8_hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:27 INFO - Running setup.py (path:/tmp/pip-10kZtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:27 INFO - Running setup.py (path:/tmp/pip-fxEUz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:27 INFO - Running setup.py (path:/tmp/pip-26MWEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:27 INFO - Running setup.py (path:/tmp/pip-5VMwhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:27 INFO - Running setup.py (path:/tmp/pip-5OEx9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:27 INFO - Running setup.py (path:/tmp/pip-1SoFM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:27 INFO - Running setup.py (path:/tmp/pip-WXl0sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:27 INFO - Running setup.py (path:/tmp/pip-JpDEM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:27 INFO - Running setup.py (path:/tmp/pip-YMUb9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:27 INFO - Running setup.py (path:/tmp/pip-tihqGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:27 INFO - Running setup.py install for manifestparser 04:54:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:54:27 INFO - Running setup.py install for mozcrash 04:54:28 INFO - Running setup.py install for mozdebug 04:54:28 INFO - Running setup.py install for mozdevice 04:54:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozfile 04:54:28 INFO - Running setup.py install for mozhttpd 04:54:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozinfo 04:54:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozInstall 04:54:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for mozleak 04:54:28 INFO - Running setup.py install for mozlog 04:54:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:54:28 INFO - Running setup.py install for moznetwork 04:54:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Running setup.py install for mozprocess 04:54:29 INFO - Running setup.py install for mozprofile 04:54:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Running setup.py install for mozrunner 04:54:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Running setup.py install for mozscreenshot 04:54:29 INFO - Running setup.py install for moztest 04:54:29 INFO - Running setup.py install for mozversion 04:54:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:54:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:29 INFO - Cleaning up... 04:54:29 INFO - Return code: 0 04:54:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54: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:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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 0x7fbc2d1ace30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, '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': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', '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:54: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:54: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:54:29 INFO - Using env: {'DISPLAY': ':0', 04:54:29 INFO - 'HOME': '/home/cltbld', 04:54:29 INFO - 'LANG': 'en_US.UTF-8', 04:54:29 INFO - 'LANGUAGE': 'en_US:en', 04:54:29 INFO - 'LOGNAME': 'cltbld', 04:54:29 INFO - 'MAIL': '/var/mail/cltbld', 04:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:29 INFO - 'MOZ_NO_REMOTE': '1', 04:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:29 INFO - 'NO_EM_RESTART': '1', 04:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:29 INFO - 'PWD': '/builds/slave/test', 04:54:29 INFO - 'SHELL': '/bin/bash', 04:54:29 INFO - 'SHLVL': '1', 04:54:29 INFO - 'TERM': 'linux', 04:54:29 INFO - 'TMOUT': '86400', 04:54:29 INFO - 'USER': 'cltbld', 04:54:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:29 INFO - '_': '/tools/buildbot/bin/python'} 04:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:29 INFO - Running setup.py (path:/tmp/pip-C3jRKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54: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:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:29 INFO - Running setup.py (path:/tmp/pip-jWbH5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:30 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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:30 INFO - Running setup.py (path:/tmp/pip-rggzGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:30 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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:30 INFO - Running setup.py (path:/tmp/pip-400pCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:30 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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:30 INFO - Running setup.py (path:/tmp/pip-HhGAMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:30 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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:30 INFO - Running setup.py (path:/tmp/pip-BKJWgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54: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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:30 INFO - Running setup.py (path:/tmp/pip-lUWZb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54: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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:30 INFO - Running setup.py (path:/tmp/pip-e1vwoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54: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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:30 INFO - Running setup.py (path:/tmp/pip-LaELiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54: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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:30 INFO - Running setup.py (path:/tmp/pip-8v6urw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54: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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:30 INFO - Running setup.py (path:/tmp/pip-Rl8n62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54: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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:30 INFO - Running setup.py (path:/tmp/pip-ldYomw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54: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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:30 INFO - Running setup.py (path:/tmp/pip-ySPO9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54: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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:30 INFO - Running setup.py (path:/tmp/pip-fgTKsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54: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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:30 INFO - Running setup.py (path:/tmp/pip-MeDFZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54: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:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:30 INFO - Running setup.py (path:/tmp/pip-3m3UzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:31 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:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:31 INFO - Running setup.py (path:/tmp/pip-9e4vyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:31 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:54:31 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:54:31 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:54:31 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:54:31 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:54:31 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:54:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:31 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:54:31 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:54:31 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:54:31 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:54:31 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:54:31 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:54:33 INFO - Downloading blessings-1.6.tar.gz 04:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:33 INFO - Installing collected packages: blessings 04:54:33 INFO - Running setup.py install for blessings 04:54:33 INFO - Successfully installed blessings 04:54:33 INFO - Cleaning up... 04:54:33 INFO - Return code: 0 04:54:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:54:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:33 INFO - Reading from file tmpfile_stdout 04:54:33 INFO - Current package versions: 04:54:33 INFO - argparse == 1.2.1 04:54:33 INFO - blessings == 1.6 04:54:33 INFO - blobuploader == 1.2.4 04:54:33 INFO - docopt == 0.6.1 04:54:33 INFO - functools32 == 3.2.3-2 04:54:33 INFO - jsonschema == 2.5.1 04:54:33 INFO - manifestparser == 1.1 04:54:33 INFO - mozInstall == 1.12 04:54:33 INFO - mozcrash == 1.0 04:54:33 INFO - mozdebug == 0.1 04:54:33 INFO - mozdevice == 0.49 04:54:33 INFO - mozfile == 1.2 04:54:33 INFO - mozhttpd == 0.7 04:54:33 INFO - mozinfo == 0.9 04:54:33 INFO - mozleak == 0.1 04:54:33 INFO - mozlog == 3.4 04:54:33 INFO - moznetwork == 0.27 04:54:33 INFO - mozprocess == 0.23 04:54:33 INFO - mozprofile == 0.28 04:54:33 INFO - mozrunner == 6.13 04:54:33 INFO - mozscreenshot == 0.1 04:54:33 INFO - mozsystemmonitor == 0.3 04:54:33 INFO - moztest == 0.7 04:54:33 INFO - mozversion == 1.4 04:54:33 INFO - psutil == 3.1.1 04:54:33 INFO - requests == 1.2.3 04:54:33 INFO - wsgiref == 0.1.2 04:54:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54: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:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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 0x7fbc2d1ace30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, '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': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', '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:54: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:54: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:54:33 INFO - Using env: {'DISPLAY': ':0', 04:54:33 INFO - 'HOME': '/home/cltbld', 04:54:33 INFO - 'LANG': 'en_US.UTF-8', 04:54:33 INFO - 'LANGUAGE': 'en_US:en', 04:54:33 INFO - 'LOGNAME': 'cltbld', 04:54:33 INFO - 'MAIL': '/var/mail/cltbld', 04:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:33 INFO - 'MOZ_NO_REMOTE': '1', 04:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:33 INFO - 'NO_EM_RESTART': '1', 04:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:33 INFO - 'PWD': '/builds/slave/test', 04:54:33 INFO - 'SHELL': '/bin/bash', 04:54:33 INFO - 'SHLVL': '1', 04:54:33 INFO - 'TERM': 'linux', 04:54:33 INFO - 'TMOUT': '86400', 04:54:33 INFO - 'USER': 'cltbld', 04:54:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:33 INFO - '_': '/tools/buildbot/bin/python'} 04:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54: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:54: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:54: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:54: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:54: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:54: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:54: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:54: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:54: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:54: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:54: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:54:33 INFO - Cleaning up... 04:54:33 INFO - Return code: 0 04:54:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54: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:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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 0x7fbc2d1ace30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, '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': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', '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:54: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:54: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:54:33 INFO - Using env: {'DISPLAY': ':0', 04:54:33 INFO - 'HOME': '/home/cltbld', 04:54:33 INFO - 'LANG': 'en_US.UTF-8', 04:54:33 INFO - 'LANGUAGE': 'en_US:en', 04:54:33 INFO - 'LOGNAME': 'cltbld', 04:54:33 INFO - 'MAIL': '/var/mail/cltbld', 04:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:33 INFO - 'MOZ_NO_REMOTE': '1', 04:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:33 INFO - 'NO_EM_RESTART': '1', 04:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:33 INFO - 'PWD': '/builds/slave/test', 04:54:33 INFO - 'SHELL': '/bin/bash', 04:54:33 INFO - 'SHLVL': '1', 04:54:33 INFO - 'TERM': 'linux', 04:54:33 INFO - 'TMOUT': '86400', 04:54:33 INFO - 'USER': 'cltbld', 04:54:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:33 INFO - '_': '/tools/buildbot/bin/python'} 04:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:54:34 INFO - Cleaning up... 04:54:34 INFO - Return code: 0 04:54:34 INFO - Running post-action listener: _resource_record_post_action 04:54:34 INFO - Running post-action listener: _start_resource_monitoring 04:54:34 INFO - Starting resource monitoring. 04:54:34 INFO - [mozharness: 2016-12-04 12:54:34.048828Z] Finished create-virtualenv step (success) 04:54:34 INFO - [mozharness: 2016-12-04 12:54:34.049384Z] Running install step. 04:54:34 INFO - Running pre-action listener: _resource_record_pre_action 04:54:34 INFO - Running main action method: install 04:54:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:34 INFO - Reading from file tmpfile_stdout 04:54:34 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:34 INFO - Reading from file tmpfile_stdout 04:54:34 INFO - Output received: 04:54:34 INFO - Usage: mozinstall [options] installer 04:54:34 INFO - Options: 04:54:34 INFO - -h, --help show this help message and exit 04:54:34 INFO - -d DEST, --destination=DEST 04:54:34 INFO - Directory to install application into. [default: 04:54:34 INFO - "/builds/slave/test"] 04:54:34 INFO - --app=APP Application being installed. [default: firefox] 04:54:34 INFO - mkdir: /builds/slave/test/build/application 04:54: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:54: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:54:51 INFO - Reading from file tmpfile_stdout 04:54:51 INFO - Output received: 04:54:51 INFO - /builds/slave/test/build/application/firefox/firefox 04:54:51 INFO - Running post-action listener: _resource_record_post_action 04:54:51 INFO - [mozharness: 2016-12-04 12:54:51.333602Z] Finished install step (success) 04:54:51 INFO - [mozharness: 2016-12-04 12:54:51.333845Z] Running run-tests step. 04:54:51 INFO - Running pre-action listener: _resource_record_pre_action 04:54:51 INFO - Running main action method: run_tests 04:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:51 INFO - Python 2.7.3 04:54:51 INFO - Return code: 0 04:54:51 INFO - grabbing minidump binary from tooltool 04:54: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:54: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 0x2959f20>, '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 0x28c6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c6f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54: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:54: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:54: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:54:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:51 INFO - Return code: 0 04:54:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:54:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:54:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54: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/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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:54: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/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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:54:51 INFO - Using env: {'DISPLAY': ':0', 04:54:51 INFO - 'HOME': '/home/cltbld', 04:54:51 INFO - 'LANG': 'en_US.UTF-8', 04:54:51 INFO - 'LANGUAGE': 'en_US:en', 04:54:51 INFO - 'LOGNAME': 'cltbld', 04:54:51 INFO - 'MAIL': '/var/mail/cltbld', 04:54:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:51 INFO - 'MOZ_NO_REMOTE': '1', 04:54:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:51 INFO - 'NO_EM_RESTART': '1', 04:54:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:51 INFO - 'PWD': '/builds/slave/test', 04:54:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:51 INFO - 'SHELL': '/bin/bash', 04:54:51 INFO - 'SHLVL': '1', 04:54:51 INFO - 'TERM': 'linux', 04:54:51 INFO - 'TMOUT': '86400', 04:54:51 INFO - 'USER': 'cltbld', 04:54:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595', 04:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:51 INFO - '_': '/tools/buildbot/bin/python'} 04:54: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/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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:54:51 INFO - mozversion application_buildid: 20161204030210 04:54:51 INFO - mozversion application_changeset: 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 04:54:51 INFO - mozversion application_display_name: Nightly 04:54:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:51 INFO - mozversion application_name: Firefox 04:54:51 INFO - mozversion application_remotingname: firefox 04:54:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:54:51 INFO - mozversion application_vendor: Mozilla 04:54:51 INFO - mozversion application_version: 53.0a1 04:54:51 INFO - mozversion platform_buildid: 20161204030210 04:54:51 INFO - mozversion platform_changeset: 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 04:54:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:54:51 INFO - mozversion platform_version: 53.0a1 04:54:51 INFO - using testdate: 1480856091 04:54:51 INFO - actual date: 1480856091 04:54:51 INFO - starting webserver on 'localhost:60250' 04:54:51 INFO - SUITE-START | Running 2 tests 04:54:51 INFO - TEST-START | dromaeo_css 04:54:51 INFO - operating with platform_type : linux_ 04:54:51 INFO - Initialising browser for dromaeo_css test... 04:54:51 INFO - TEST-INFO | started process 30782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLXzOeh/profile http://localhost:60250/getInfo.html) 04:54:55 INFO - PROCESS | 30782 | __metrics Screen width/height:1600/1200 04:54:55 INFO - PROCESS | 30782 | colorDepth:24 04:54:55 INFO - PROCESS | 30782 | Browser inner width/height: 1024/697 04:54:55 INFO - PROCESS | 30782 | __metrics 04:54:56 INFO - PROCESS | 30782 | 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:54:56 INFO - PROCESS | 30782 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:54:56 INFO - PROCESS | 30782 | console.error: PushService: 04:54:56 INFO - PROCESS | 30782 | stateChangeProcessEnqueue: Error transitioning state 04:54:56 INFO - PROCESS | 30782 | UnknownError 04:54:57 INFO - TEST-INFO | 30782: exit 0 04:54:57 INFO - Browser initialized. 04:54:57 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:57 INFO - TEST-INFO | started process 30869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLXzOeh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:09 INFO - PROCESS | 30869 | RSS: Main: 172158976 04:55:09 INFO - PROCESS | 30869 | 04:56:00 INFO - PROCESS | 30869 | 1480856160568 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:58:11 INFO - PROCESS | 30869 | Cycle 1(1): loaded http://localhost:60250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60250/tests/dromaeo/cssquery-ext.html) 04:58:13 INFO - PROCESS | 30869 | RSS: Main: 343023616 04:58:13 INFO - PROCESS | 30869 | 05:01:15 INFO - PROCESS | 30869 | Cycle 1(1): loaded http://localhost:60250/tests/dromaeo/cssquery-ext.html (next: http://localhost:60250/tests/dromaeo/cssquery-jquery.html) 05:01:16 INFO - PROCESS | 30869 | RSS: Main: 276582400 05:01:16 INFO - PROCESS | 30869 | 05:04:18 INFO - PROCESS | 30869 | Cycle 1(1): loaded http://localhost:60250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60250/tests/dromaeo/cssquery-mootools.html) 05:04:19 INFO - PROCESS | 30869 | RSS: Main: 216436736 05:04:19 INFO - PROCESS | 30869 | 05:07:21 INFO - PROCESS | 30869 | Cycle 1(1): loaded http://localhost:60250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60250/tests/dromaeo/cssquery-prototype.html) 05:07:21 INFO - PROCESS | 30869 | RSS: Main: 224567296 05:07:21 INFO - PROCESS | 30869 | 05:10:24 INFO - PROCESS | 30869 | Cycle 1(1): loaded http://localhost:60250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60250/tests/dromaeo/cssquery-yui.html) 05:10:25 INFO - PROCESS | 30869 | RSS: Main: 220114944 05:10:25 INFO - PROCESS | 30869 | 05:13:28 INFO - PROCESS | 30869 | Cycle 1(1): loaded http://localhost:60250/tests/dromaeo/cssquery-yui.html (next: http://localhost:60250/tests/dromaeo/cssquery-dojo.html) 05:13:28 INFO - PROCESS | 30869 | RSS: Main: 312410112 05:13:28 INFO - PROCESS | 30869 | 05:13:28 INFO - PROCESS | 30869 | __start_tp_report 05:13:28 INFO - PROCESS | 30869 | _x_x_mozilla_page_load 05:13:28 INFO - PROCESS | 30869 | _x_x_mozilla_page_load_details 05:13:28 INFO - PROCESS | 30869 | |i|pagename|runs| 05:13:28 INFO - PROCESS | 30869 | |0;dojo.html;3256.511523271509;3289.1777055736065;3308.404487192306;3313.188268874125;3313.9171520711993;5306.92039619406;5335.0663633864115;5361.865953351168;5446.074167391543;5467.781288748451;5416.593755468346;5422.349318081836;5439.048166570854;5442.482964118412;5442.537384322328;4905.117078925792;4928.137575924216;4938.061768264019;4969.8509044728535;4971.825986090487;4879.926801097969;4908.19014862549;4934.037862616791;4936.210206366982;4938.901221975559;4870.756462176894;4903.0929278083495;4930.556249937505;4930.876728081791;4931.901361972758;4949.554540091409;4970.850874473772;4975.925361119586;4993.051320249141;5050.217216331474;4747.169245382079;4782.3543821584335;4828.85513434594;4902.779374928136;4908;5300.337457817773;5324.1747529133045;5336.38631557372;5343.225232341328;5393.865153371158;5646.322441307069;5713.885722285531;5727.713614319309;5729.8567535811935;5734.827955161351;5547.278853748987;5660.037793575061;5685.800996965087;5780.104083867007;5782.97108514459;5342.412334643186;5367.677939323653;5367.946320536823;5413.02565538203;5419.160030195326;5810.448007439287;5819.825405237765;5825.33008703996;5830.096335068071;5830.941690583039;5502.58730595207;5603.047481928001;5611.831645050655;5612.719364031782;5616.943830561642;5670.092785154356;5671.631343962629;5703.885922281531;5723.313202415737;5785.913211301834;5642.0972644377525;5692.402297758676;5694.231278777312;5699.487046165782;5700.572457065737;5561.888762224733;5716.399778023331;5720.914186287209;5730.942690573124;5733.111367738007;4388.648908087409;4425.690201685851;4440.267355886307;4441.156180325728;4442.111577684476;3986.820593073319;4019.577944315805;4029.697772667003;4054.2499637567144;4054.675625949917;5483.424240454775;5491.725413729378;5509.5041446270025;5510.366307874646;5557.110862262019;5564.4713752193475;5754.223179870748;5762.769489220468;5763.654180749085;5770.105633626795;5306.336707911511;5412.052890744104;5441.700706461103;5455.481729235717;5484.314460692413;4895.069936712013;4937.407511098691;4940.90118197634;4945.184044632595;4947.950520494821;5953.464188223081;5991.3409524953095;5997.250343707036;6005.309389420273;6007.249093863267;5640.492355688008;5662.2639056922335;5714.971425142848;5751.022326204639;5757.740901659519;5997.490213331741;6000.399960003964;6008.489278411209;6011.879762404815;6048.4858787003595;5637.57718171147;5673.74468148926;5680.318361796611;5681.0910254359105;5682;5650.124230744241;5695.202671626059;5712.11462223356;5718.79984200551;5772.278465191851;5601.663900166003;5647.887042259214;5650.886982260414;5682.744276507485;5702.657840529581;5576.386597474356;5626.493615574454;5632.352279487911;5632.408597097246;5660.51885589713;5455.481729235717;5491.945080549303;5495.340559132929;5555.472230138131;5568.192612071146;5642.266505354278;5648.406917273627;5653.067243904709;5654.15187721845;5669.461401166883;5573.749181286771;5574.442555744393;5581.972090139686;5615;5627.606067575231 05:13:28 INFO - PROCESS | 30869 | |1;ext.html;546.0871965223904;592.4697395830731;619.4053708439898;619.584878131652;620.3765215957962;31653.683463165362;42045.36931946023;42884.571154288446;42972.355414668804;45860.54139458604;43051.138977220515;43417.34873976893;43488.130237395235;43514.12971740563;43598.56401435985;7814.765557033298;8009.759707208793;8546.230839224469;8699.434536755123;8705.085965973576;9995.950020249926;10247.128994035516;10276.486175691185;10602.681919542387;10603.946980265087;10421.791564168712;10490.632827851026;10495.527701253424;10495.895041049567;10501.78996420071;10258.9487052565;10320.071193592576;10347.844782328271;10403.635872744493;10407.53166107527;10151.593936242542;10213.74465638365;10216.846747298796;10229.897701022968;10234.744131396701;39776.60223397758;40139.39790903139;40174.19651606952;40214.79892600518;40236.79881600603;3107.4095921775015;3141.4816555268353;3231.8222497762613;3523.94714079289;3843.0584506796013;28624.85687571549;30370.392592148033;31130.37739245225;31292.53061204084;31309.530357044663;4108.4864391951005;4130.215259100762;4173.373993900909;4201.159768046372;4343.891402714926;324907;326488;327813;334621;335353;61532;62324;62374;62384.08278551326;62389.376106239266;64943.63486389863;65215.673921630085;65241.673791631685;65271.67364163149;65358.34641653618;16633.168341582874;17106;17126.486205413607;17131.800773945703;17132.743008854875;11741.647750567497;12167;12892.548760793326;12963.675908102185;13080.607581772561;18736.906315468335;19124;19413.611727765365;19425.812176827098;19510.90244548768;7373;7496.287852653989;7570.810729731691;7667.8849817252785;7706.845863082707;914.8947870994921;1011.4487604255698;1042.1402343066848;1075.44077079918;1082.6427278997912;30765.84617076945;30802.229944251572;30829;30911.381772364428;30972.22569435782;1033.9069483746498;1070.571771291474;1092.4210168610648;1108.8156332025897;1152.7694461107644;15722.764158537631;16140.112293823717;16146.653272760866;16195.676086478205;16586.58533536671;473225;476500;478263;478747;479146;57001.429985700444;57569.42430575641;57571.42428575744;57605.423945760005;57637.71181144068;1208.667616405478;1251.249250449723;1281.4681907008674;1281.525835440893;1353.4247944623496;26264.4747105053;30454.39091218119;30608.84695576508;30708.53937190899;31207.531887022167;47211.527884720716;47751.28373074337;47761.52238477571;47784;47787.76106119447;381296;383441;383755;383957;384058;25576;26297.86851065809;27906.86046569754;27913.860430697718;41028.38457423081;42580;42955.570444295154;43250.567494324656;43443.782781085894;44118.558814411444;36591.63408365989;36808.05462792226;36899.81550092233;37484.625153749206;38042.239155216186;35588;36808;36920.26159476849;37149.628503714615;37471.62528374681;36076.81961590175;36105.0973725659;36112.63887361093;36269.81865090658;36668.63331366652;31438.528422074145;33230.169245768084;34158;34299.657003429646;34403.311933760684;24286.75713242845;24294.75705242925;24499.94293568581;24602;24684.629730554414 05:13:28 INFO - PROCESS | 30869 | |2;jquery.html;379.0731661088636;390.60939060939063;391.5673181134846;394.76906009984157;424.3782858112864;13592.3203839808;15199.924000379997;18605.534861628465;18662.62674746504;19203.903980480078;17876.106194690277;18040.097995100226;18305.908470457663;18399.44801655949;18409.263629454807;5450.482204190605;5704.743286552115;5710.000749868777;5712.742926568314;5713.200151978726;4651.906961860761;6265.4987600992035;6285.937140628604;6377.234731832164;6378.489720822323;6107.725152368132;6204.317525072239;6333.0051033924165;6338.2569793306975;6347.746090156388;6215.81352559424;6248.50011999039;6254.593451425642;6255.562110652256;6258.123862659231;5102.132637451605;5133.537981581676;5134.1528647773075;5278.47215278473;5550.306211723535;18384.26462941494;18498.90750546252;19074;21715.34853954384;21783.564328713495;2217.889105544716;2250.3024062540503;2474.2206205045354;2600.2329312852753;2906.6512018557696;13431.731365372736;13852.16886986784;13862.376193071335;14147.717045659132;14374.20941848198;1803.9458816235533;1888.499547619882;1950.3856285270235;1960.11794692389;1961.2449207055245;77582.22417775806;77936;78675;79498.6025069871;81982.59008704919;10030.498475076218;10079.34484258521;10100.848487272697;10153.13698335635;10324.380537167794;14617.634559135893;14662.706745865236;14676;14677.633059173393;14678.41286348534;7920.564368959647;7966.6415011324625;8047.1550487198;8168.346532277404;8239.95880020596;7710.498817576839;7803.141654418009;8011.639476223584;8041.236082572146;8042;6183;6319.33646967071;6360.872782544416;6390.4248617624635;6456;1703.9148042597822;1852.8610354223488;1884.4158310923658;1901.1198034977022;1917.712343148511;704.0565642039692;873.157403105993;883.2757139145839;906.2840356118725;1005.5073014222978;16802.495925122264;18469.261229550935;18521.29046328029;18641.737695903164;18678.159482823306;911.3438324406417;960.7646126699003;968.951552422376;985.5121714751244;1062.9627963021412;9568.186704130227;10480.423576703355;10481.580736770444;10498.527566259536;10621.309614875008;463978;465297;465593;471541;475368;86616;94295.52852235695;97188.51405742926;99420;100052.49973750231;1004.9447280399502;1033.6743925663393;1039.7452624107143;1079.7192729890128;1084.2627013630806;16013.599660008127;16297.67404651924;16370.427035053715;16789.832101679316;16969.745453817955;40661.39007914943;40893.38659920163;40977;41897.58102418937;43585.782071089445;55618.16572751331;56175.43824561702;59089.70455147697;59603;61216.93915304306;7944.602769861599;7968.880466792887;7994.2805147537;8229.79425514367;8232.34141268685;11451.656450306504;12306.200096994025;12360.4437800301;12413.44139513742;12799.488020479077;10253.384796912209;10840.241183117107;10916.727081823017;11128.1653875958;11508.36703981289;5711.086226203954;8807.955960220157;10541.947290263499;10775.390244268257;11302.660920172408;10979.231453798158;11229.21395502307;11335.489902954221;11351.602693905674;11738.647840564796;7951.84096318082;7979.361651068017;7994.440389172934;8160.755177344689;8195.50826950361;9682.419054856731;10492.685219443429;10988.670339889815;11038.116950643769;11057.391843448688 05:13:28 INFO - PROCESS | 30869 | |3;mootools.html;1369.2742846291467;1402.172718096323;1473.8968272220948;1665.3421898350152;1668.8915220510673;7118.181409137937;7368.300011498913;7833.451658383916;8303.958480207599;8310.75067747967;7777.844443111135;8078.717244896415;8119.715809946653;8318.168183181679;8350.95824520878;2289.347535952254;2324.430514523944;2324.639680849471;2328.2898715891647;2328.5342931413784;1958.3537432647192;2236.3738153317017;2284.5316710074476;2295.9770402296012;2296.850704704189;2022.2315520102413;2164.77269886662;2240.5854916840435;2244.55108978205;2255.8872056397195;2237.9216727414623;2252.40311317501;2259.4803195265017;2259.5593859197547;2296.0586159674453;2163.383435720828;2183.803457688816;2184.6395344768093;2184.7705990871045;2188.737351517812;8007.879881801778;8082.676692932276;8125.471844330159;8174.46865953717;8254.793630159234;5127.307813445174;5287.259783630295;5287.524122828925;5290.788368465257;5293.602979776532;3082.475979083561;3097.6282846058616;3345.7323414126813;3372.4772660237704;3375.6793104655017;1157.311399717167;1172.818213176959;2016.1330627830027;2026.5642886779265;2045.734054572896;11262.493187806569;11323.037541808957;11406.258593191416;11410.087193024538;11417.885821141848;4299.54854740254;4471.731696098244;4494.640428765691;4552.499225085238;4586.289125185602;8966.775830604287;8994;8998.190162885372;9001;9007.144321289466;5046.924296135561;5096.184610462308;5116.283720279164;5116.309298244763;5119.436861945258;4658.930116048262;4748.905021899543;4754.9286760698615;4773.856784296477;4780.95219047812;3516.1385460562324;3531;3594.5327107476382;3635.4910312556262;3663.395539735967;1059.4490864750442;1110.294962698676;1120.2326406411635;1122.119136477861;1129.757102223026;784.172697803811;907.8002839375326;918.1094338491653;932.3054324528134;934.9065093490733;5266.868328291746;5361.946380536223;5412.729363531807;5420.91868621971;5521.861953451196;855.7432770168924;905.9547022648841;909.8862642169729;914.1955079529971;918.3709159225951;3559.6440355964196;3593.443016332473;3629.1834337273904;3695.2609478104487;3728.7389882708494;9664.420134791935;10202.33684810485;10237.43694096817;10247.84628230577;10248.743781405525;9901.455419951828;9973.351732137387;10098.747531311628;10195.541200645988;10200;7347.63261836906;7501.174870764212;7507.512011719221;7511.661975211128;7517.887231691419;5028.4971502850885;5065.924011139762;5077.213031980049;5117.1045067113855;5319.281896943863;8809.075047120217;8848.778780530538;8900.332475064266;8928.196462318423;9018.81962360736;9004.234640055407;9017.323700722342;9082.36423450352;9103;9199.218066464426;6469;6809.761658341934;6851.9657401712675;6854.074699915447;6859.7256109757045;7566.697332106654;7631.618419079135;7633.351165151024;7641.35048520882;7649;6426.614403135827;6791.219009813737;6807;6914.827129321807;6920.446364290744;6826.2832402599;6886.51794374409;6903;7092.6099064551945;7330.486865919548;6027;6071;6109.480694141048;6121.908171377344;6126.448619624255;4725.834595789131;4734.360861283682;4764.952350476451;4882.731449770296;4919.803207871788;4622.445306563234;4645.465771436328;4658.347831303552;4729.55069268419;4895.8041678332465 05:13:28 INFO - PROCESS | 30869 | |4;prototype.html;330.3343762318928;330.55870412998644;334.6168636910737;335.6073394128868;341.26798018250867;5146.433892271847;5263.26314315996;5270.578353731702;5324.5740340772745;5339.919901201475;5078.339815823938;5117.616178786588;5172.818951336704;5189.662671926331;5191.740412979355;4143.896402589944;4146.44023056888;4154.50145982481;4157.459530261061;4159.771212583307;3859.286032084073;3977.701672374569;4170.165966806636;4177.33162693969;4195.643370313527;4024.3762216856435;4028.5367182773916;4053.918921621566;4054.756714597119;4062.6343629073376;4009.659178969791;4016.6585840203616;4028.9194216115807;4044.939325910114;4048.1701251243717;3572.964270357289;3588.9282214355826;3589.5154154189113;3597.892063238081;3598.9280214395826;4898.24077268024;5076.162433198518;5117.667351622133;5150.253213284091;5154.778263585259;4649.04694537619;4665.976670116662;4700.2009658358165;4703.176944034814;4711.1284412383475;5430.239766432703;5445.346558413015;5445.564354851603;5480.561555075585;5495.53287970523;3875.418687196915;3975.960240397617;3996.160806230695;4009.8195581198624;4016.5581786003518;5696.8860622787315;5704.80033198836;5707.200991861143;5712.600117991742;5723.939381822541;3943.7830919299713;3944.3097457944746;3947.131631041166;3951.9802400988387;3955.129871428281;3905.2970465316516;3987.265539490273;3993.281209382339;4087.7956102195367;4090.4886889138857;4648.163330600457;4670.416197975253;4676.883077923079;4679.976600116977;4685.531446855355;5468.7539060742365;5483.327585086587;5509.3664228613425;5543.196236545759;5544.390117087117;1285.7428514297178;1307.843058832946;1361.748076605831;1388.611188867119;1403.2983508245877;918.3617385916724;952.6284748947916;953.7458242411207;954.4321128928276;955.7419496735843;5101.770420331094;5111.437741848394;5129.20477832763;5135.972805438927;5165.354330708661;5380;5453.727313634303;5455.972720136453;5470.972645136749;5474.507294343528;4906.73701988181;5131.691418688285;5196.1166601677805;5209.192575150858;5217.50433708797;2862.2844288927768;2872.8850845965926;2892;2898.318895059659;2900.622919020556;5619;5647.802326918538;5665.235193248941;5666.348369937427;5710.544465879711;5244.475552444725;5455.981286923864;5494.917576236359;5514.283143191359;5528.972355138279;5606.971965140148;5625;5633.0568601978775;5641.266635337462;5643.463870932255;5222.634415590872;5414.3232095988005;5419.620626556103;5423.29497165366;5431.8098866539485;5223.343659438332;5236.423993360803;5271.894562108813;5343.7595308212;5394.676319420847;5592.888142237214;5637.238972738792;5642.351129620146;5669.914951275817;5722.456366645162;3831.7700937943814;3899.6100389960775;3980.8805735827973;3983.5418926823786;3991.860284890015;5406.296851574213;5408.323959505062;5430.294061771944;5450.637340664834;5482.753276102505;5398.62209645321;5429.701366424884;5445;5508.118701007819;5508.614396992172;5477.479639434407;5516.758729285879;5538.39695343188;5563.610547261815;5571.804986825442;5302.761375738024;5451.4276001019325;5468.28912241406;5477.4796394342475;5481.972590137024;5558.583106266965;5560.805371811967;5563.165525171256;5580.720963951705;5584.3857175711455;5450.672959622435;5472.781088756565;5486.807961721321;5488.807891723771;5492.588055895903 05:13:28 INFO - PROCESS | 30869 | |5;yui.html;715.5527795128045;728.4645785347772;730.2259604818893;765.877459606463;772.1930582541244;14927.477538286148;16156.838431615695;16184.595385115348;16204;16211;14734.557963261093;14881.404743810263;14891.180985045818;14891.404343826262;14896.10623362599;655.8458762190882;668.3450218785594;754.2495217258835;770.5492287012105;771.4098714483424;785.5679376343018;794.761571528542;794.8688466403065;795.9005124359455;796.3271035974592;837.8240569480416;838.1032295443878;839.5382539603224;839.6011894350165;839.9916000839975;689.362339835655;703.282651695268;807.4590024683476;835.3192148399065;835.5028757889046;596.4125336543501;602.7317843559617;604.4288147700424;605.7001784116846;606.160467752162;15194.316255768517;15209.543713688496;15248.39006439741;15249.08505489663;15249.695006099926;13877.861221387759;13936.86063139376;13949.721005579933;13950;13955.720885582334;11700.765984680258;11951.521939122425;12041.698957526132;12390.876091239152;12413.813792793115;3822.368749687808;3964.048628329209;3984.8406063757416;4109.691773117028;4111.321631930728;81037.18962810356;81529.18470815335;82016.58991705063;82130.58934705348;82249;10118.342307749972;10634.946825265824;10779.514921828537;11041.779164416666;11091.33451992883;20413.69379459309;20646.17415303371;20651.27720529774;20780.27269045576;20788.1684732612;7651.977468899753;7686.461947663722;7689.92310076892;7720.459567830198;7849.4897831640765;4462.330650402466;4463.285874260103;4519.570640789119;4522.525134860858;4568.634509239253;3213.6786321368145;3277.115178901683;3294.1435226841195;3555.1289933965827;3719.0516418313696;586.3608666553478;603.1039484927331;605.276694350256;614.7325913227671;615.2524682510771;608.7564974010431;644.5069521815815;649.6589290622461;657.2999755260632;663.598522893652;9079.591418386188;9253.72238832836;9326.626934922528;9532.571034303473;9537.761555961019;641.9952773908818;644.7872202173365;651.1795138125996;656.2485953583121;667.7095463473307;4365.301551751704;4547.295169248771;4584.931226031612;4680.424004274;4740.1230772307235;86243.56878215694;86720;87845;89498.55250723705;91979.54010229906;57487;60089.69955150284;77143;78369;79311;61462.69268653718;62757.372426276976;63557.682211588646;63984.36015639877;64303.67848160823;8781.648734050566;8832.29341652679;8864.73405797827;8936;9327.533623318943;42851.78574107109;44135.33796992983;44571.17723208215;45184.32223516716;46732.766336168104;55418.44581554133;55489.445105548424;58690.4130958685;60082.09876851763;62358;12367.196132251735;12410.75178496407;12446.751064978469;12624.87375126237;12887;14039.36822842995;14144.646383840074;14150.929245353707;14355;14356.49752258666;13026.54407095747;13113.737725245632;13180.255108161246;13195.274259915797;13491.797623035465;12574.87425125737;12921;13177.868221318047;13647.317634118453;13819.447222111405;11523.53905843757;11568.421578921188;11711.238769479956;12835;12850.67873303175;9327.300452465957;9551.474668893277;9876.753081173028;9962.50187490608;10054.597816087275;7937.2459616336355;8732.476051436934;9063.864042039242;9263.907360926305;9316.767080823034 05:13:28 INFO - PROCESS | 30869 | __end_tp_report 05:13:28 INFO - PROCESS | 30869 | __start_cc_report 05:13:28 INFO - PROCESS | 30869 | _x_x_mozilla_cycle_collect,1623 05:13:28 INFO - PROCESS | 30869 | __end_cc_report 05:13:28 INFO - PROCESS | 30869 | __startTimestamp1480857208424__endTimestamp 05:13:28 INFO - PROCESS | 30869 | 05:13:28 INFO - PROCESS | 30869 | ------- Summary: start ------- 05:13:28 INFO - PROCESS | 30869 | Number of tests: 6 05:13:28 INFO - PROCESS | 30869 | 05:13:28 INFO - PROCESS | 30869 | [#0] dojo.html Cycles:165 Average:5348.87 Median:5564.47 stddev:568.59 (10.2%) stddev-sans-first:546.13 05:13:28 INFO - PROCESS | 30869 | Values: 3256.5 3289.2 3308.4 3313.2 3313.9 5306.9 5335.1 5361.9 5446.1 5467.8 5416.6 5422.3 5439.0 5442.5 5442.5 4905.1 4928.1 4938.1 4969.9 4971.8 4879.9 4908.2 4934.0 4936.2 4938.9 4870.8 4903.1 4930.6 4930.9 4931.9 4949.6 4970.9 4975.9 4993.1 5050.2 4747.2 4782.4 4828.9 4902.8 4908.0 5300.3 5324.2 5336.4 5343.2 5393.9 5646.3 5713.9 5727.7 5729.9 5734.8 5547.3 5660.0 5685.8 5780.1 5783.0 5342.4 5367.7 5367.9 5413.0 5419.2 5810.4 5819.8 5825.3 5830.1 5830.9 5502.6 5603.0 5611.8 5612.7 5616.9 5670.1 5671.6 5703.9 5723.3 5785.9 5642.1 5692.4 5694.2 5699.5 5700.6 5561.9 5716.4 5720.9 5730.9 5733.1 4388.6 4425.7 4440.3 4441.2 4442.1 3986.8 4019.6 4029.7 4054.2 4054.7 5483.4 5491.7 5509.5 5510.4 5557.1 5564.5 5754.2 5762.8 5763.7 5770.1 5306.3 5412.1 5441.7 5455.5 5484.3 4895.1 4937.4 4940.9 4945.2 4948.0 5953.5 5991.3 5997.3 6005.3 6007.2 5640.5 5662.3 5715.0 5751.0 5757.7 5997.5 6000.4 6008.5 6011.9 6048.5 5637.6 5673.7 5680.3 5681.1 5682.0 5650.1 5695.2 5712.1 5718.8 5772.3 5601.7 5647.9 5650.9 5682.7 5702.7 5576.4 5626.5 5632.4 5632.4 5660.5 5455.5 5491.9 5495.3 5555.5 5568.2 5642.3 5648.4 5653.1 5654.2 5669.5 5573.7 5574.4 5582.0 5615.0 5627.6 05:13:28 INFO - PROCESS | 30869 | 05:13:28 INFO - PROCESS | 30869 | [#1] ext.html Cycles:180 Average:55937.68 Median:18963.63 stddev:106059.51 (559.3%) stddev-sans-first:106275.50 05:13:28 INFO - PROCESS | 30869 | Values: 546.1 592.5 619.4 619.6 620.4 31653.7 42045.4 42884.6 42972.4 45860.5 43051.1 43417.3 43488.1 43514.1 43598.6 7814.8 8009.8 8546.2 8699.4 8705.1 9996.0 10247.1 10276.5 10602.7 10603.9 10421.8 10490.6 10495.5 10495.9 10501.8 10258.9 10320.1 10347.8 10403.6 10407.5 10151.6 10213.7 10216.8 10229.9 10234.7 39776.6 40139.4 40174.2 40214.8 40236.8 3107.4 3141.5 3231.8 3523.9 3843.1 28624.9 30370.4 31130.4 31292.5 31309.5 4108.5 4130.2 4173.4 4201.2 4343.9 324907.0 326488.0 327813.0 334621.0 335353.0 61532.0 62324.0 62374.0 62384.1 62389.4 64943.6 65215.7 65241.7 65271.7 65358.3 16633.2 17106.0 17126.5 17131.8 17132.7 11741.6 12167.0 12892.5 12963.7 13080.6 18736.9 19124.0 19413.6 19425.8 19510.9 7373.0 7496.3 7570.8 7667.9 7706.8 914.9 1011.4 1042.1 1075.4 1082.6 30765.8 30802.2 30829.0 30911.4 30972.2 1033.9 1070.6 1092.4 1108.8 1152.8 15722.8 16140.1 16146.7 16195.7 16586.6 473225.0 476500.0 478263.0 478747.0 479146.0 57001.4 57569.4 57571.4 57605.4 57637.7 1208.7 1251.2 1281.5 1281.5 1353.4 26264.5 30454.4 30608.8 30708.5 31207.5 47211.5 47751.3 47761.5 47784.0 47787.8 381296.0 383441.0 383755.0 383957.0 384058.0 25576.0 26297.9 27906.9 27913.9 41028.4 42580.0 42955.6 43250.6 43443.8 44118.6 36591.6 36808.1 36899.8 37484.6 38042.2 35588.0 36808.0 36920.3 37149.6 37471.6 36076.8 36105.1 36112.6 36269.8 36668.6 31438.5 33230.2 34158.0 34299.7 34403.3 24286.8 24294.8 24499.9 24602.0 24684.6 05:13:28 INFO - PROCESS | 30869 | 05:13:28 INFO - PROCESS | 30869 | [#2] jquery.html Cycles:180 Average:28163.67 Median:391.09 stddev:77444.46 (19802.3%) stddev-sans-first:77633.61 05:13:28 INFO - PROCESS | 30869 | Values: 379.1 390.6 391.6 394.8 424.4 13592.3 15199.9 18605.5 18662.6 19203.9 17876.1 18040.1 18305.9 18399.4 18409.3 5450.5 5704.7 5710.0 5712.7 5713.2 4651.9 6265.5 6285.9 6377.2 6378.5 6107.7 6204.3 6333.0 6338.3 6347.7 6215.8 6248.5 6254.6 6255.6 6258.1 5102.1 5133.5 5134.2 5278.5 5550.3 18384.3 18498.9 19074.0 21715.3 21783.6 2217.9 2250.3 2474.2 2600.2 2906.7 13431.7 13852.2 13862.4 14147.7 14374.2 1803.9 1888.5 1950.4 1960.1 1961.2 77582.2 77936.0 78675.0 79498.6 81982.6 10030.5 10079.3 10100.8 10153.1 10324.4 14617.6 14662.7 14676.0 14677.6 14678.4 7920.6 7966.6 8047.2 8168.3 8240.0 7710.5 7803.1 8011.6 8041.2 8042.0 6183.0 6319.3 6360.9 6390.4 6456.0 1703.9 1852.9 1884.4 1901.1 1917.7 704.1 873.2 883.3 906.3 1005.5 16802.5 18469.3 18521.3 18641.7 18678.2 911.3 960.8 969.0 985.5 1063.0 9568.2 10480.4 10481.6 10498.5 10621.3 463978.0 465297.0 465593.0 471541.0 475368.0 86616.0 94295.5 97188.5 99420.0 100052.5 1004.9 1033.7 1039.7 1079.7 1084.3 16013.6 16297.7 16370.4 16789.8 16969.7 40661.4 40893.4 40977.0 41897.6 43585.8 55618.2 56175.4 59089.7 59603.0 61216.9 7944.6 7968.9 7994.3 8229.8 8232.3 11451.7 12306.2 12360.4 12413.4 12799.5 10253.4 10840.2 10916.7 11128.2 11508.4 5711.1 8808.0 10541.9 10775.4 11302.7 10979.2 11229.2 11335.5 11351.6 11738.6 7951.8 7979.4 7994.4 8160.8 8195.5 9682.4 10492.7 10988.7 11038.1 11057.4 05:13:28 INFO - PROCESS | 30869 | 05:13:28 INFO - PROCESS | 30869 | [#3] mootools.html Cycles:180 Average:5324.58 Median:5086.70 stddev:2928.15 (57.6%) stddev-sans-first:2921.27 05:13:28 INFO - PROCESS | 30869 | Values: 1369.3 1402.2 1473.9 1665.3 1668.9 7118.2 7368.3 7833.5 8304.0 8310.8 7777.8 8078.7 8119.7 8318.2 8351.0 2289.3 2324.4 2324.6 2328.3 2328.5 1958.4 2236.4 2284.5 2296.0 2296.9 2022.2 2164.8 2240.6 2244.6 2255.9 2237.9 2252.4 2259.5 2259.6 2296.1 2163.4 2183.8 2184.6 2184.8 2188.7 8007.9 8082.7 8125.5 8174.5 8254.8 5127.3 5287.3 5287.5 5290.8 5293.6 3082.5 3097.6 3345.7 3372.5 3375.7 1157.3 1172.8 2016.1 2026.6 2045.7 11262.5 11323.0 11406.3 11410.1 11417.9 4299.5 4471.7 4494.6 4552.5 4586.3 8966.8 8994.0 8998.2 9001.0 9007.1 5046.9 5096.2 5116.3 5116.3 5119.4 4658.9 4748.9 4754.9 4773.9 4781.0 3516.1 3531.0 3594.5 3635.5 3663.4 1059.4 1110.3 1120.2 1122.1 1129.8 784.2 907.8 918.1 932.3 934.9 5266.9 5361.9 5412.7 5420.9 5521.9 855.7 906.0 909.9 914.2 918.4 3559.6 3593.4 3629.2 3695.3 3728.7 9664.4 10202.3 10237.4 10247.8 10248.7 9901.5 9973.4 10098.7 10195.5 10200.0 7347.6 7501.2 7507.5 7511.7 7517.9 5028.5 5065.9 5077.2 5117.1 5319.3 8809.1 8848.8 8900.3 8928.2 9018.8 9004.2 9017.3 9082.4 9103.0 9199.2 6469.0 6809.8 6852.0 6854.1 6859.7 7566.7 7631.6 7633.4 7641.4 7649.0 6426.6 6791.2 6807.0 6914.8 6920.4 6826.3 6886.5 6903.0 7092.6 7330.5 6027.0 6071.0 6109.5 6121.9 6126.4 4725.8 4734.4 4765.0 4882.7 4919.8 4622.4 4645.5 4658.3 4729.6 4895.8 05:13:28 INFO - PROCESS | 30869 | 05:13:28 INFO - PROCESS | 30869 | [#4] prototype.html Cycles:180 Average:4569.60 Median:5220.07 stddev:1334.29 (25.6%) stddev-sans-first:1299.54 05:13:28 INFO - PROCESS | 30869 | Values: 330.3 330.6 334.6 335.6 341.3 5146.4 5263.3 5270.6 5324.6 5339.9 5078.3 5117.6 5172.8 5189.7 5191.7 4143.9 4146.4 4154.5 4157.5 4159.8 3859.3 3977.7 4170.2 4177.3 4195.6 4024.4 4028.5 4053.9 4054.8 4062.6 4009.7 4016.7 4028.9 4044.9 4048.2 3573.0 3588.9 3589.5 3597.9 3598.9 4898.2 5076.2 5117.7 5150.3 5154.8 4649.0 4666.0 4700.2 4703.2 4711.1 5430.2 5445.3 5445.6 5480.6 5495.5 3875.4 3976.0 3996.2 4009.8 4016.6 5696.9 5704.8 5707.2 5712.6 5723.9 3943.8 3944.3 3947.1 3952.0 3955.1 3905.3 3987.3 3993.3 4087.8 4090.5 4648.2 4670.4 4676.9 4680.0 4685.5 5468.8 5483.3 5509.4 5543.2 5544.4 1285.7 1307.8 1361.7 1388.6 1403.3 918.4 952.6 953.7 954.4 955.7 5101.8 5111.4 5129.2 5136.0 5165.4 5380.0 5453.7 5456.0 5471.0 5474.5 4906.7 5131.7 5196.1 5209.2 5217.5 2862.3 2872.9 2892.0 2898.3 2900.6 5619.0 5647.8 5665.2 5666.3 5710.5 5244.5 5456.0 5494.9 5514.3 5529.0 5607.0 5625.0 5633.1 5641.3 5643.5 5222.6 5414.3 5419.6 5423.3 5431.8 5223.3 5236.4 5271.9 5343.8 5394.7 5592.9 5637.2 5642.4 5669.9 5722.5 3831.8 3899.6 3980.9 3983.5 3991.9 5406.3 5408.3 5430.3 5450.6 5482.8 5398.6 5429.7 5445.0 5508.1 5508.6 5477.5 5516.8 5538.4 5563.6 5571.8 5302.8 5451.4 5468.3 5477.5 5482.0 5558.6 5560.8 5563.2 5580.7 5584.4 5450.7 5472.8 5486.8 5488.8 5492.6 05:13:28 INFO - PROCESS | 30869 | 05:13:28 INFO - PROCESS | 30869 | [#5] yui.html Cycles:180 Average:17869.16 Median:29643.41 stddev:23882.14 (80.6%) stddev-sans-first:23914.40 05:13:28 INFO - PROCESS | 30869 | Values: 715.6 728.5 730.2 765.9 772.2 14927.5 16156.8 16184.6 16204.0 16211.0 14734.6 14881.4 14891.2 14891.4 14896.1 655.8 668.3 754.2 770.5 771.4 785.6 794.8 794.9 795.9 796.3 837.8 838.1 839.5 839.6 840.0 689.4 703.3 807.5 835.3 835.5 596.4 602.7 604.4 605.7 606.2 15194.3 15209.5 15248.4 15249.1 15249.7 13877.9 13936.9 13949.7 13950.0 13955.7 11700.8 11951.5 12041.7 12390.9 12413.8 3822.4 3964.0 3984.8 4109.7 4111.3 81037.2 81529.2 82016.6 82130.6 82249.0 10118.3 10634.9 10779.5 11041.8 11091.3 20413.7 20646.2 20651.3 20780.3 20788.2 7652.0 7686.5 7689.9 7720.5 7849.5 4462.3 4463.3 4519.6 4522.5 4568.6 3213.7 3277.1 3294.1 3555.1 3719.1 586.4 603.1 605.3 614.7 615.3 608.8 644.5 649.7 657.3 663.6 9079.6 9253.7 9326.6 9532.6 9537.8 642.0 644.8 651.2 656.2 667.7 4365.3 4547.3 4584.9 4680.4 4740.1 86243.6 86720.0 87845.0 89498.6 91979.5 57487.0 60089.7 77143.0 78369.0 79311.0 61462.7 62757.4 63557.7 63984.4 64303.7 8781.6 8832.3 8864.7 8936.0 9327.5 42851.8 44135.3 44571.2 45184.3 46732.8 55418.4 55489.4 58690.4 60082.1 62358.0 12367.2 12410.8 12446.8 12624.9 12887.0 14039.4 14144.6 14150.9 14355.0 14356.5 13026.5 13113.7 13180.3 13195.3 13491.8 12574.9 12921.0 13177.9 13647.3 13819.4 11523.5 11568.4 11711.2 12835.0 12850.7 9327.3 9551.5 9876.8 9962.5 10054.6 7937.2 8732.5 9063.9 9263.9 9316.8 05:13:28 INFO - PROCESS | 30869 | -------- Summary: end -------- 05:13:28 INFO - PROCESS | 30869 | 05:13:29 INFO - TEST-INFO | 30869: exit 0 05:13:29 INFO - TEST-OK | dromaeo_css | took 1117741ms 05:13:29 INFO - TEST-START | kraken 05:13:29 INFO - operating with platform_type : linux_ 05:13:29 INFO - Initialising browser for kraken test... 05:13:29 INFO - TEST-INFO | started process 31174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYdAnEj/profile http://localhost:60250/getInfo.html) 05:13:33 INFO - PROCESS | 31174 | __metrics Screen width/height:1600/1200 05:13:33 INFO - PROCESS | 31174 | colorDepth:24 05:13:33 INFO - PROCESS | 31174 | Browser inner width/height: 1024/697 05:13:33 INFO - PROCESS | 31174 | __metrics 05:13:33 INFO - PROCESS | 31174 | 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:13:33 INFO - PROCESS | 31174 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:13:34 INFO - PROCESS | 31174 | console.error: PushService: 05:13:34 INFO - PROCESS | 31174 | stateChangeProcessEnqueue: Error transitioning state 05:13:34 INFO - PROCESS | 31174 | UnknownError 05:13:34 INFO - TEST-INFO | 31174: exit 0 05:13:34 INFO - Browser initialized. 05:13:34 INFO - Running cycle 1/1 for kraken test... 05:13:34 INFO - TEST-INFO | started process 31258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYdAnEj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:47 INFO - PROCESS | 31258 | RSS: Main: 171745280 05:13:47 INFO - PROCESS | 31258 | 05:13:49 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60250/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:50 INFO - PROCESS | 31258 | RSS: Main: 234778624 05:13:50 INFO - PROCESS | 31258 | 05:13:53 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60250/tests/kraken/driver.html?testName=audio-dft) 05:13:53 INFO - PROCESS | 31258 | RSS: Main: 217042944 05:13:53 INFO - PROCESS | 31258 | 05:13:56 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60250/tests/kraken/driver.html?testName=audio-fft) 05:13:57 INFO - PROCESS | 31258 | RSS: Main: 298758144 05:13:57 INFO - PROCESS | 31258 | 05:13:59 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60250/tests/kraken/driver.html?testName=audio-oscillator) 05:14:00 INFO - PROCESS | 31258 | RSS: Main: 208715776 05:14:00 INFO - PROCESS | 31258 | 05:14:02 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:02 INFO - PROCESS | 31258 | RSS: Main: 214196224 05:14:02 INFO - PROCESS | 31258 | 05:14:05 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60250/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:06 INFO - PROCESS | 31258 | RSS: Main: 252628992 05:14:06 INFO - PROCESS | 31258 | 05:14:09 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60250/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:10 INFO - PROCESS | 31258 | RSS: Main: 252227584 05:14:10 INFO - PROCESS | 31258 | 05:14:13 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60250/tests/kraken/driver.html?testName=json-parse-financial) 05:14:13 INFO - PROCESS | 31258 | RSS: Main: 251174912 05:14:13 INFO - PROCESS | 31258 | 05:14:15 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:16 INFO - PROCESS | 31258 | RSS: Main: 212930560 05:14:16 INFO - PROCESS | 31258 | 05:14:17 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60250/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:18 INFO - PROCESS | 31258 | RSS: Main: 220352512 05:14:18 INFO - PROCESS | 31258 | 05:14:20 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:21 INFO - PROCESS | 31258 | RSS: Main: 230424576 05:14:21 INFO - PROCESS | 31258 | 05:14:23 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:24 INFO - PROCESS | 31258 | RSS: Main: 238444544 05:14:24 INFO - PROCESS | 31258 | 05:14:27 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:27 INFO - PROCESS | 31258 | RSS: Main: 235253760 05:14:27 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | Cycle 1(1): loaded http://localhost:60250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60250/tests/kraken/driver.html?testName=ai-astar) 05:14:29 INFO - PROCESS | 31258 | RSS: Main: 286523392 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | __start_tp_report 05:14:29 INFO - PROCESS | 31258 | _x_x_mozilla_page_load 05:14:29 INFO - PROCESS | 31258 | _x_x_mozilla_page_load_details 05:14:29 INFO - PROCESS | 31258 | |i|pagename|runs| 05:14:29 INFO - PROCESS | 31258 | |0;ai-astar;110;111;111;112;114;112;112;112;111;111 05:14:29 INFO - PROCESS | 31258 | |1;audio-beat-detection;154;129;130;169;130;124;127;128;151;124 05:14:29 INFO - PROCESS | 31258 | |2;audio-dft;160;161;160;161;162;162;165;161;161;161 05:14:29 INFO - PROCESS | 31258 | |3;audio-fft;75;76;76;105;79;75;75;75;89;75 05:14:29 INFO - PROCESS | 31258 | |4;audio-oscillator;82;83;106;83;82;83;93;82;82;112 05:14:29 INFO - PROCESS | 31258 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 05:14:29 INFO - PROCESS | 31258 | |6;imaging-darkroom;174;146;147;146;146;146;146;146;146;146 05:14:29 INFO - PROCESS | 31258 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 05:14:29 INFO - PROCESS | 31258 | |8;json-parse-financial;54;52;52;52;54;53;53;58;53;55 05:14:29 INFO - PROCESS | 31258 | |9;json-stringify-tinderbox;62;63;63;63;63;62;67;63;63;66 05:14:29 INFO - PROCESS | 31258 | |10;stanford-crypto-aes;81;80;80;89;80;81;80;80;79;81 05:14:29 INFO - PROCESS | 31258 | |11;stanford-crypto-ccm;142;131;137;133;140;134;132;144;185;131 05:14:29 INFO - PROCESS | 31258 | |12;stanford-crypto-pbkdf2;168;165;165;164;166;170;165;167;167;164 05:14:29 INFO - PROCESS | 31258 | |13;stanford-crypto-sha256-iterative;66;67;70;67;66;73;74;66;66;66 05:14:29 INFO - PROCESS | 31258 | __end_tp_report 05:14:29 INFO - PROCESS | 31258 | __start_cc_report 05:14:29 INFO - PROCESS | 31258 | _x_x_mozilla_cycle_collect,1679 05:14:29 INFO - PROCESS | 31258 | __end_cc_report 05:14:29 INFO - PROCESS | 31258 | __startTimestamp1480857269840__endTimestamp 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | ------- Summary: start ------- 05:14:29 INFO - PROCESS | 31258 | Number of tests: 14 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.07 (1.0%) stddev-sans-first:0.97 05:14:29 INFO - PROCESS | 31258 | Values: 110.0 111.0 111.0 112.0 114.0 112.0 112.0 112.0 111.0 111.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:130.00 stddev:15.59 (12.0%) stddev-sans-first:15.22 05:14:29 INFO - PROCESS | 31258 | Values: 154.0 129.0 130.0 169.0 130.0 124.0 127.0 128.0 151.0 124.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.42 05:14:29 INFO - PROCESS | 31258 | Values: 160.0 161.0 160.0 161.0 162.0 162.0 165.0 161.0 161.0 161.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#3] audio-fft Cycles:10 Average:80.00 Median:75.50 stddev:9.80 (13.0%) stddev-sans-first:10.22 05:14:29 INFO - PROCESS | 31258 | Values: 75.0 76.0 76.0 105.0 79.0 75.0 75.0 75.0 89.0 75.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.50 stddev:11.24 (13.6%) stddev-sans-first:11.65 05:14:29 INFO - PROCESS | 31258 | Values: 82.0 83.0 106.0 83.0 82.0 83.0 93.0 82.0 82.0 112.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:14:29 INFO - PROCESS | 31258 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:146.00 stddev:8.82 (6.0%) stddev-sans-first:0.33 05:14:29 INFO - PROCESS | 31258 | Values: 174.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:14:29 INFO - PROCESS | 31258 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:1.84 (3.4%) stddev-sans-first:1.94 05:14:29 INFO - PROCESS | 31258 | Values: 54.0 52.0 52.0 52.0 54.0 53.0 53.0 58.0 53.0 55.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.00 stddev:1.65 (2.6%) stddev-sans-first:1.66 05:14:29 INFO - PROCESS | 31258 | Values: 62.0 63.0 63.0 63.0 63.0 62.0 67.0 63.0 63.0 66.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.50 stddev:2.85 (3.5%) stddev-sans-first:3.02 05:14:29 INFO - PROCESS | 31258 | Values: 81.0 80.0 80.0 89.0 80.0 81.0 80.0 80.0 79.0 81.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:138.50 stddev:16.18 (11.7%) stddev-sans-first:17.16 05:14:29 INFO - PROCESS | 31258 | Values: 142.0 131.0 137.0 133.0 140.0 134.0 132.0 144.0 185.0 131.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:166.50 stddev:1.91 (1.1%) stddev-sans-first:1.90 05:14:29 INFO - PROCESS | 31258 | Values: 168.0 165.0 165.0 164.0 166.0 170.0 165.0 167.0 167.0 164.0 05:14:29 INFO - PROCESS | 31258 | 05:14:29 INFO - PROCESS | 31258 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.00 stddev:3.11 (4.6%) stddev-sans-first:3.20 05:14:29 INFO - PROCESS | 31258 | Values: 66.0 67.0 70.0 67.0 66.0 73.0 74.0 66.0 66.0 66.0 05:14:29 INFO - PROCESS | 31258 | -------- Summary: end -------- 05:14:29 INFO - PROCESS | 31258 | 05:14:31 INFO - TEST-INFO | 31258: exit 0 05:14:31 INFO - TEST-OK | kraken | took 61716ms 05:14:31 INFO - SUITE-END | took 1179s 05:14:31 INFO - Completed test suite (00:19:39) 05:14:31 INFO - javascript benchmark 05:14:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.511523271509, 3289.1777055736065, 3308.404487192306, 3313.188268874125, 3313.9171520711993, 5306.92039619406, 5335.0663633864115, 5361.865953351168, 5446.074167391543, 5467.781288748451, 5416.593755468346, 5422.349318081836, 5439.048166570854, 5442.482964118412, 5442.537384322328, 4905.117078925792, 4928.137575924216, 4938.061768264019, 4969.8509044728535, 4971.825986090487, 4879.926801097969, 4908.19014862549, 4934.037862616791, 4936.210206366982, 4938.901221975559, 4870.756462176894, 4903.0929278083495, 4930.556249937505, 4930.876728081791, 4931.901361972758, 4949.554540091409, 4970.850874473772, 4975.925361119586, 4993.051320249141, 5050.217216331474, 4747.169245382079, 4782.3543821584335, 4828.85513434594, 4902.779374928136, 4908.0, 5300.337457817773, 5324.1747529133045, 5336.38631557372, 5343.225232341328, 5393.865153371158, 5646.322441307069, 5713.885722285531, 5727.713614319309, 5729.8567535811935, 5734.827955161351, 5547.278853748987, 5660.037793575061, 5685.800996965087, 5780.104083867007, 5782.97108514459, 5342.412334643186, 5367.677939323653, 5367.946320536823, 5413.02565538203, 5419.160030195326, 5810.448007439287, 5819.825405237765, 5825.33008703996, 5830.096335068071, 5830.941690583039, 5502.58730595207, 5603.047481928001, 5611.831645050655, 5612.719364031782, 5616.943830561642, 5670.092785154356, 5671.631343962629, 5703.885922281531, 5723.313202415737, 5785.913211301834, 5642.0972644377525, 5692.402297758676, 5694.231278777312, 5699.487046165782, 5700.572457065737, 5561.888762224733, 5716.399778023331, 5720.914186287209, 5730.942690573124, 5733.111367738007, 4388.648908087409, 4425.690201685851, 4440.267355886307, 4441.156180325728, 4442.111577684476, 3986.820593073319, 4019.577944315805, 4029.697772667003, 4054.2499637567144, 4054.675625949917, 5483.424240454775, 5491.725413729378, 5509.5041446270025, 5510.366307874646, 5557.110862262019, 5564.4713752193475, 5754.223179870748, 5762.769489220468, 5763.654180749085, 5770.105633626795, 5306.336707911511, 5412.052890744104, 5441.700706461103, 5455.481729235717, 5484.314460692413, 4895.069936712013, 4937.407511098691, 4940.90118197634, 4945.184044632595, 4947.950520494821, 5953.464188223081, 5991.3409524953095, 5997.250343707036, 6005.309389420273, 6007.249093863267, 5640.492355688008, 5662.2639056922335, 5714.971425142848, 5751.022326204639, 5757.740901659519, 5997.490213331741, 6000.399960003964, 6008.489278411209, 6011.879762404815, 6048.4858787003595, 5637.57718171147, 5673.74468148926, 5680.318361796611, 5681.0910254359105, 5682.0, 5650.124230744241, 5695.202671626059, 5712.11462223356, 5718.79984200551, 5772.278465191851, 5601.663900166003, 5647.887042259214, 5650.886982260414, 5682.744276507485, 5702.657840529581, 5576.386597474356, 5626.493615574454, 5632.352279487911, 5632.408597097246, 5660.51885589713, 5455.481729235717, 5491.945080549303, 5495.340559132929, 5555.472230138131, 5568.192612071146, 5642.266505354278, 5648.406917273627, 5653.067243904709, 5654.15187721845, 5669.461401166883, 5573.749181286771, 5574.442555744393, 5581.972090139686, 5615.0, 5627.606067575231], "value": 5313.663899040812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.0871965223904, 592.4697395830731, 619.4053708439898, 619.584878131652, 620.3765215957962, 31653.683463165362, 42045.36931946023, 42884.571154288446, 42972.355414668804, 45860.54139458604, 43051.138977220515, 43417.34873976893, 43488.130237395235, 43514.12971740563, 43598.56401435985, 7814.765557033298, 8009.759707208793, 8546.230839224469, 8699.434536755123, 8705.085965973576, 9995.950020249926, 10247.128994035516, 10276.486175691185, 10602.681919542387, 10603.946980265087, 10421.791564168712, 10490.632827851026, 10495.527701253424, 10495.895041049567, 10501.78996420071, 10258.9487052565, 10320.071193592576, 10347.844782328271, 10403.635872744493, 10407.53166107527, 10151.593936242542, 10213.74465638365, 10216.846747298796, 10229.897701022968, 10234.744131396701, 39776.60223397758, 40139.39790903139, 40174.19651606952, 40214.79892600518, 40236.79881600603, 3107.4095921775015, 3141.4816555268353, 3231.8222497762613, 3523.94714079289, 3843.0584506796013, 28624.85687571549, 30370.392592148033, 31130.37739245225, 31292.53061204084, 31309.530357044663, 4108.4864391951005, 4130.215259100762, 4173.373993900909, 4201.159768046372, 4343.891402714926, 324907.0, 326488.0, 327813.0, 334621.0, 335353.0, 61532.0, 62324.0, 62374.0, 62384.08278551326, 62389.376106239266, 64943.63486389863, 65215.673921630085, 65241.673791631685, 65271.67364163149, 65358.34641653618, 16633.168341582874, 17106.0, 17126.486205413607, 17131.800773945703, 17132.743008854875, 11741.647750567497, 12167.0, 12892.548760793326, 12963.675908102185, 13080.607581772561, 18736.906315468335, 19124.0, 19413.611727765365, 19425.812176827098, 19510.90244548768, 7373.0, 7496.287852653989, 7570.810729731691, 7667.8849817252785, 7706.845863082707, 914.8947870994921, 1011.4487604255698, 1042.1402343066848, 1075.44077079918, 1082.6427278997912, 30765.84617076945, 30802.229944251572, 30829.0, 30911.381772364428, 30972.22569435782, 1033.9069483746498, 1070.571771291474, 1092.4210168610648, 1108.8156332025897, 1152.7694461107644, 15722.764158537631, 16140.112293823717, 16146.653272760866, 16195.676086478205, 16586.58533536671, 473225.0, 476500.0, 478263.0, 478747.0, 479146.0, 57001.429985700444, 57569.42430575641, 57571.42428575744, 57605.423945760005, 57637.71181144068, 1208.667616405478, 1251.249250449723, 1281.4681907008674, 1281.525835440893, 1353.4247944623496, 26264.4747105053, 30454.39091218119, 30608.84695576508, 30708.53937190899, 31207.531887022167, 47211.527884720716, 47751.28373074337, 47761.52238477571, 47784.0, 47787.76106119447, 381296.0, 383441.0, 383755.0, 383957.0, 384058.0, 25576.0, 26297.86851065809, 27906.86046569754, 27913.860430697718, 41028.38457423081, 42580.0, 42955.570444295154, 43250.567494324656, 43443.782781085894, 44118.558814411444, 36591.63408365989, 36808.05462792226, 36899.81550092233, 37484.625153749206, 38042.239155216186, 35588.0, 36808.0, 36920.26159476849, 37149.628503714615, 37471.62528374681, 36076.81961590175, 36105.0973725659, 36112.63887361093, 36269.81865090658, 36668.63331366652, 31438.528422074145, 33230.169245768084, 34158.0, 34299.657003429646, 34403.311933760684, 24286.75713242845, 24294.75705242925, 24499.94293568581, 24602.0, 24684.629730554414], "value": 19718.497439261322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.0731661088636, 390.60939060939063, 391.5673181134846, 394.76906009984157, 424.3782858112864, 13592.3203839808, 15199.924000379997, 18605.534861628465, 18662.62674746504, 19203.903980480078, 17876.106194690277, 18040.097995100226, 18305.908470457663, 18399.44801655949, 18409.263629454807, 5450.482204190605, 5704.743286552115, 5710.000749868777, 5712.742926568314, 5713.200151978726, 4651.906961860761, 6265.4987600992035, 6285.937140628604, 6377.234731832164, 6378.489720822323, 6107.725152368132, 6204.317525072239, 6333.0051033924165, 6338.2569793306975, 6347.746090156388, 6215.81352559424, 6248.50011999039, 6254.593451425642, 6255.562110652256, 6258.123862659231, 5102.132637451605, 5133.537981581676, 5134.1528647773075, 5278.47215278473, 5550.306211723535, 18384.26462941494, 18498.90750546252, 19074.0, 21715.34853954384, 21783.564328713495, 2217.889105544716, 2250.3024062540503, 2474.2206205045354, 2600.2329312852753, 2906.6512018557696, 13431.731365372736, 13852.16886986784, 13862.376193071335, 14147.717045659132, 14374.20941848198, 1803.9458816235533, 1888.499547619882, 1950.3856285270235, 1960.11794692389, 1961.2449207055245, 77582.22417775806, 77936.0, 78675.0, 79498.6025069871, 81982.59008704919, 10030.498475076218, 10079.34484258521, 10100.848487272697, 10153.13698335635, 10324.380537167794, 14617.634559135893, 14662.706745865236, 14676.0, 14677.633059173393, 14678.41286348534, 7920.564368959647, 7966.6415011324625, 8047.1550487198, 8168.346532277404, 8239.95880020596, 7710.498817576839, 7803.141654418009, 8011.639476223584, 8041.236082572146, 8042.0, 6183.0, 6319.33646967071, 6360.872782544416, 6390.4248617624635, 6456.0, 1703.9148042597822, 1852.8610354223488, 1884.4158310923658, 1901.1198034977022, 1917.712343148511, 704.0565642039692, 873.157403105993, 883.2757139145839, 906.2840356118725, 1005.5073014222978, 16802.495925122264, 18469.261229550935, 18521.29046328029, 18641.737695903164, 18678.159482823306, 911.3438324406417, 960.7646126699003, 968.951552422376, 985.5121714751244, 1062.9627963021412, 9568.186704130227, 10480.423576703355, 10481.580736770444, 10498.527566259536, 10621.309614875008, 463978.0, 465297.0, 465593.0, 471541.0, 475368.0, 86616.0, 94295.52852235695, 97188.51405742926, 99420.0, 100052.49973750231, 1004.9447280399502, 1033.6743925663393, 1039.7452624107143, 1079.7192729890128, 1084.2627013630806, 16013.599660008127, 16297.67404651924, 16370.427035053715, 16789.832101679316, 16969.745453817955, 40661.39007914943, 40893.38659920163, 40977.0, 41897.58102418937, 43585.782071089445, 55618.16572751331, 56175.43824561702, 59089.70455147697, 59603.0, 61216.93915304306, 7944.602769861599, 7968.880466792887, 7994.2805147537, 8229.79425514367, 8232.34141268685, 11451.656450306504, 12306.200096994025, 12360.4437800301, 12413.44139513742, 12799.488020479077, 10253.384796912209, 10840.241183117107, 10916.727081823017, 11128.1653875958, 11508.36703981289, 5711.086226203954, 8807.955960220157, 10541.947290263499, 10775.390244268257, 11302.660920172408, 10979.231453798158, 11229.21395502307, 11335.489902954221, 11351.602693905674, 11738.647840564796, 7951.84096318082, 7979.361651068017, 7994.440389172934, 8160.755177344689, 8195.50826950361, 9682.419054856731, 10492.685219443429, 10988.670339889815, 11038.116950643769, 11057.391843448688], "value": 9072.265603416263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.2742846291467, 1402.172718096323, 1473.8968272220948, 1665.3421898350152, 1668.8915220510673, 7118.181409137937, 7368.300011498913, 7833.451658383916, 8303.958480207599, 8310.75067747967, 7777.844443111135, 8078.717244896415, 8119.715809946653, 8318.168183181679, 8350.95824520878, 2289.347535952254, 2324.430514523944, 2324.639680849471, 2328.2898715891647, 2328.5342931413784, 1958.3537432647192, 2236.3738153317017, 2284.5316710074476, 2295.9770402296012, 2296.850704704189, 2022.2315520102413, 2164.77269886662, 2240.5854916840435, 2244.55108978205, 2255.8872056397195, 2237.9216727414623, 2252.40311317501, 2259.4803195265017, 2259.5593859197547, 2296.0586159674453, 2163.383435720828, 2183.803457688816, 2184.6395344768093, 2184.7705990871045, 2188.737351517812, 8007.879881801778, 8082.676692932276, 8125.471844330159, 8174.46865953717, 8254.793630159234, 5127.307813445174, 5287.259783630295, 5287.524122828925, 5290.788368465257, 5293.602979776532, 3082.475979083561, 3097.6282846058616, 3345.7323414126813, 3372.4772660237704, 3375.6793104655017, 1157.311399717167, 1172.818213176959, 2016.1330627830027, 2026.5642886779265, 2045.734054572896, 11262.493187806569, 11323.037541808957, 11406.258593191416, 11410.087193024538, 11417.885821141848, 4299.54854740254, 4471.731696098244, 4494.640428765691, 4552.499225085238, 4586.289125185602, 8966.775830604287, 8994.0, 8998.190162885372, 9001.0, 9007.144321289466, 5046.924296135561, 5096.184610462308, 5116.283720279164, 5116.309298244763, 5119.436861945258, 4658.930116048262, 4748.905021899543, 4754.9286760698615, 4773.856784296477, 4780.95219047812, 3516.1385460562324, 3531.0, 3594.5327107476382, 3635.4910312556262, 3663.395539735967, 1059.4490864750442, 1110.294962698676, 1120.2326406411635, 1122.119136477861, 1129.757102223026, 784.172697803811, 907.8002839375326, 918.1094338491653, 932.3054324528134, 934.9065093490733, 5266.868328291746, 5361.946380536223, 5412.729363531807, 5420.91868621971, 5521.861953451196, 855.7432770168924, 905.9547022648841, 909.8862642169729, 914.1955079529971, 918.3709159225951, 3559.6440355964196, 3593.443016332473, 3629.1834337273904, 3695.2609478104487, 3728.7389882708494, 9664.420134791935, 10202.33684810485, 10237.43694096817, 10247.84628230577, 10248.743781405525, 9901.455419951828, 9973.351732137387, 10098.747531311628, 10195.541200645988, 10200.0, 7347.63261836906, 7501.174870764212, 7507.512011719221, 7511.661975211128, 7517.887231691419, 5028.4971502850885, 5065.924011139762, 5077.213031980049, 5117.1045067113855, 5319.281896943863, 8809.075047120217, 8848.778780530538, 8900.332475064266, 8928.196462318423, 9018.81962360736, 9004.234640055407, 9017.323700722342, 9082.36423450352, 9103.0, 9199.218066464426, 6469.0, 6809.761658341934, 6851.9657401712675, 6854.074699915447, 6859.7256109757045, 7566.697332106654, 7631.618419079135, 7633.351165151024, 7641.35048520882, 7649.0, 6426.614403135827, 6791.219009813737, 6807.0, 6914.827129321807, 6920.446364290744, 6826.2832402599, 6886.51794374409, 6903.0, 7092.6099064551945, 7330.486865919548, 6027.0, 6071.0, 6109.480694141048, 6121.908171377344, 6126.448619624255, 4725.834595789131, 4734.360861283682, 4764.952350476451, 4882.731449770296, 4919.803207871788, 4622.445306563234, 4645.465771436328, 4658.347831303552, 4729.55069268419, 4895.8041678332465], "value": 4345.001532802072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.3343762318928, 330.55870412998644, 334.6168636910737, 335.6073394128868, 341.26798018250867, 5146.433892271847, 5263.26314315996, 5270.578353731702, 5324.5740340772745, 5339.919901201475, 5078.339815823938, 5117.616178786588, 5172.818951336704, 5189.662671926331, 5191.740412979355, 4143.896402589944, 4146.44023056888, 4154.50145982481, 4157.459530261061, 4159.771212583307, 3859.286032084073, 3977.701672374569, 4170.165966806636, 4177.33162693969, 4195.643370313527, 4024.3762216856435, 4028.5367182773916, 4053.918921621566, 4054.756714597119, 4062.6343629073376, 4009.659178969791, 4016.6585840203616, 4028.9194216115807, 4044.939325910114, 4048.1701251243717, 3572.964270357289, 3588.9282214355826, 3589.5154154189113, 3597.892063238081, 3598.9280214395826, 4898.24077268024, 5076.162433198518, 5117.667351622133, 5150.253213284091, 5154.778263585259, 4649.04694537619, 4665.976670116662, 4700.2009658358165, 4703.176944034814, 4711.1284412383475, 5430.239766432703, 5445.346558413015, 5445.564354851603, 5480.561555075585, 5495.53287970523, 3875.418687196915, 3975.960240397617, 3996.160806230695, 4009.8195581198624, 4016.5581786003518, 5696.8860622787315, 5704.80033198836, 5707.200991861143, 5712.600117991742, 5723.939381822541, 3943.7830919299713, 3944.3097457944746, 3947.131631041166, 3951.9802400988387, 3955.129871428281, 3905.2970465316516, 3987.265539490273, 3993.281209382339, 4087.7956102195367, 4090.4886889138857, 4648.163330600457, 4670.416197975253, 4676.883077923079, 4679.976600116977, 4685.531446855355, 5468.7539060742365, 5483.327585086587, 5509.3664228613425, 5543.196236545759, 5544.390117087117, 1285.7428514297178, 1307.843058832946, 1361.748076605831, 1388.611188867119, 1403.2983508245877, 918.3617385916724, 952.6284748947916, 953.7458242411207, 954.4321128928276, 955.7419496735843, 5101.770420331094, 5111.437741848394, 5129.20477832763, 5135.972805438927, 5165.354330708661, 5380.0, 5453.727313634303, 5455.972720136453, 5470.972645136749, 5474.507294343528, 4906.73701988181, 5131.691418688285, 5196.1166601677805, 5209.192575150858, 5217.50433708797, 2862.2844288927768, 2872.8850845965926, 2892.0, 2898.318895059659, 2900.622919020556, 5619.0, 5647.802326918538, 5665.235193248941, 5666.348369937427, 5710.544465879711, 5244.475552444725, 5455.981286923864, 5494.917576236359, 5514.283143191359, 5528.972355138279, 5606.971965140148, 5625.0, 5633.0568601978775, 5641.266635337462, 5643.463870932255, 5222.634415590872, 5414.3232095988005, 5419.620626556103, 5423.29497165366, 5431.8098866539485, 5223.343659438332, 5236.423993360803, 5271.894562108813, 5343.7595308212, 5394.676319420847, 5592.888142237214, 5637.238972738792, 5642.351129620146, 5669.914951275817, 5722.456366645162, 3831.7700937943814, 3899.6100389960775, 3980.8805735827973, 3983.5418926823786, 3991.860284890015, 5406.296851574213, 5408.323959505062, 5430.294061771944, 5450.637340664834, 5482.753276102505, 5398.62209645321, 5429.701366424884, 5445.0, 5508.118701007819, 5508.614396992172, 5477.479639434407, 5516.758729285879, 5538.39695343188, 5563.610547261815, 5571.804986825442, 5302.761375738024, 5451.4276001019325, 5468.28912241406, 5477.4796394342475, 5481.972590137024, 5558.583106266965, 5560.805371811967, 5563.165525171256, 5580.720963951705, 5584.3857175711455, 5450.672959622435, 5472.781088756565, 5486.807961721321, 5488.807891723771, 5492.588055895903], "value": 4146.172413766007, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.5527795128045, 728.4645785347772, 730.2259604818893, 765.877459606463, 772.1930582541244, 14927.477538286148, 16156.838431615695, 16184.595385115348, 16204.0, 16211.0, 14734.557963261093, 14881.404743810263, 14891.180985045818, 14891.404343826262, 14896.10623362599, 655.8458762190882, 668.3450218785594, 754.2495217258835, 770.5492287012105, 771.4098714483424, 785.5679376343018, 794.761571528542, 794.8688466403065, 795.9005124359455, 796.3271035974592, 837.8240569480416, 838.1032295443878, 839.5382539603224, 839.6011894350165, 839.9916000839975, 689.362339835655, 703.282651695268, 807.4590024683476, 835.3192148399065, 835.5028757889046, 596.4125336543501, 602.7317843559617, 604.4288147700424, 605.7001784116846, 606.160467752162, 15194.316255768517, 15209.543713688496, 15248.39006439741, 15249.08505489663, 15249.695006099926, 13877.861221387759, 13936.86063139376, 13949.721005579933, 13950.0, 13955.720885582334, 11700.765984680258, 11951.521939122425, 12041.698957526132, 12390.876091239152, 12413.813792793115, 3822.368749687808, 3964.048628329209, 3984.8406063757416, 4109.691773117028, 4111.321631930728, 81037.18962810356, 81529.18470815335, 82016.58991705063, 82130.58934705348, 82249.0, 10118.342307749972, 10634.946825265824, 10779.514921828537, 11041.779164416666, 11091.33451992883, 20413.69379459309, 20646.17415303371, 20651.27720529774, 20780.27269045576, 20788.1684732612, 7651.977468899753, 7686.461947663722, 7689.92310076892, 7720.459567830198, 7849.4897831640765, 4462.330650402466, 4463.285874260103, 4519.570640789119, 4522.525134860858, 4568.634509239253, 3213.6786321368145, 3277.115178901683, 3294.1435226841195, 3555.1289933965827, 3719.0516418313696, 586.3608666553478, 603.1039484927331, 605.276694350256, 614.7325913227671, 615.2524682510771, 608.7564974010431, 644.5069521815815, 649.6589290622461, 657.2999755260632, 663.598522893652, 9079.591418386188, 9253.72238832836, 9326.626934922528, 9532.571034303473, 9537.761555961019, 641.9952773908818, 644.7872202173365, 651.1795138125996, 656.2485953583121, 667.7095463473307, 4365.301551751704, 4547.295169248771, 4584.931226031612, 4680.424004274, 4740.1230772307235, 86243.56878215694, 86720.0, 87845.0, 89498.55250723705, 91979.54010229906, 57487.0, 60089.69955150284, 77143.0, 78369.0, 79311.0, 61462.69268653718, 62757.372426276976, 63557.682211588646, 63984.36015639877, 64303.67848160823, 8781.648734050566, 8832.29341652679, 8864.73405797827, 8936.0, 9327.533623318943, 42851.78574107109, 44135.33796992983, 44571.17723208215, 45184.32223516716, 46732.766336168104, 55418.44581554133, 55489.445105548424, 58690.4130958685, 60082.09876851763, 62358.0, 12367.196132251735, 12410.75178496407, 12446.751064978469, 12624.87375126237, 12887.0, 14039.36822842995, 14144.646383840074, 14150.929245353707, 14355.0, 14356.49752258666, 13026.54407095747, 13113.737725245632, 13180.255108161246, 13195.274259915797, 13491.797623035465, 12574.87425125737, 12921.0, 13177.868221318047, 13647.317634118453, 13819.447222111405, 11523.53905843757, 11568.421578921188, 11711.238769479956, 12835.0, 12850.67873303175, 9327.300452465957, 9551.474668893277, 9876.753081173028, 9962.50187490608, 10054.597816087275, 7937.2459616336355, 8732.476051436934, 9063.864042039242, 9263.907360926305, 9316.767080823034], "value": 7016.588049518682, "unit": "score"}], "name": "dromaeo_css", "value": 7024.7741470462315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 112.0, 114.0, 112.0, 112.0, 112.0, 111.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 130.0, 169.0, 130.0, 124.0, 127.0, 128.0, 151.0, 124.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 162.0, 162.0, 165.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 105.0, 79.0, 75.0, 75.0, 75.0, 89.0, 75.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 106.0, 83.0, 82.0, 83.0, 93.0, 82.0, 82.0, 112.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 52.0, 54.0, 53.0, 53.0, 58.0, 53.0, 55.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 67.0, 63.0, 63.0, 66.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 89.0, 80.0, 81.0, 80.0, 80.0, 79.0, 81.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 131.0, 137.0, 133.0, 140.0, 134.0, 132.0, 144.0, 185.0, 131.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 165.0, 164.0, 166.0, 170.0, 165.0, 167.0, 167.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 70.0, 67.0, 66.0, 73.0, 74.0, 66.0, 66.0, 66.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1512.4999999999998, "alertThreshold": 2.0}]} 05:14:31 INFO - Return code: 0 05:14:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:14:31 INFO - # TBPL SUCCESS # 05:14:31 INFO - Running post-action listener: _resource_record_post_action 05:14:31 INFO - [mozharness: 2016-12-04 13:14:31.650084Z] Finished run-tests step (success) 05:14:31 INFO - Running post-run listener: _resource_record_post_run 05:14:31 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 16384; Write bytes: 392785920; Read time: 436; Write time: 283112 05:14:31 INFO - TinderboxPrint: CPU usage
13.1% 05:14:31 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 436 05:14:31 INFO - TinderboxPrint: I/O write bytes / time
392,785,920 / 283,112 05:14:31 INFO - TinderboxPrint: CPU idle
8,295.9 (86.9%) 05:14:31 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 05:14:31 INFO - TinderboxPrint: Swap in / out
0 / 0 05:14:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 104054784; Read time: 220; Write time: 81844 05:14:31 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288731136; Read time: 204; Write time: 201268 05:14:32 INFO - Running post-run listener: _upload_blobber_files 05:14:32 INFO - Blob upload gear active. 05:14:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:14:32 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:14:32 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:14:32 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:14:32 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:14:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:33 INFO - (blobuploader) - INFO - Done attempting. 05:14:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:14:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:14:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:34 INFO - (blobuploader) - INFO - Done attempting. 05:14:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:14:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:14:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:37 INFO - (blobuploader) - INFO - Done attempting. 05:14:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:37 INFO - Return code: 0 05:14:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c357bf72e8c62861f7f8602e2d950fabb8afbfe2adb2676c7fe42f2132ddfbb835b8a324209d5eb4093c4ca11ab50343605eebaeeecac1f9680b6a2962c6bb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/362dbc45cee783d1189b7275e595d66df1648e18a8a9cb8382801100ff8bf6e3e5cde5445b96f208668fcecc78acfe0c1ab692b680e7d681dd78e00e067b98fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b635f7153366ec6ed5ba1f007a8595aab356bd3ae5424b7323fd1de768318c24e04f879b615345ce00fcb3bbd01db0db0db835734bfbaf91b5537f1fd8cb887e"} 05:14:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:37 INFO - Contents: 05:14:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c357bf72e8c62861f7f8602e2d950fabb8afbfe2adb2676c7fe42f2132ddfbb835b8a324209d5eb4093c4ca11ab50343605eebaeeecac1f9680b6a2962c6bb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/362dbc45cee783d1189b7275e595d66df1648e18a8a9cb8382801100ff8bf6e3e5cde5445b96f208668fcecc78acfe0c1ab692b680e7d681dd78e00e067b98fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b635f7153366ec6ed5ba1f007a8595aab356bd3ae5424b7323fd1de768318c24e04f879b615345ce00fcb3bbd01db0db0db835734bfbaf91b5537f1fd8cb887e"} 05:14:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:37 INFO - Copying logs to upload dir... 05:14:37 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.377614 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-12-04 05:14:37.138702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 05:14:37.142414) ========= 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=62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595 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/1c357bf72e8c62861f7f8602e2d950fabb8afbfe2adb2676c7fe42f2132ddfbb835b8a324209d5eb4093c4ca11ab50343605eebaeeecac1f9680b6a2962c6bb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/362dbc45cee783d1189b7275e595d66df1648e18a8a9cb8382801100ff8bf6e3e5cde5445b96f208668fcecc78acfe0c1ab692b680e7d681dd78e00e067b98fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b635f7153366ec6ed5ba1f007a8595aab356bd3ae5424b7323fd1de768318c24e04f879b615345ce00fcb3bbd01db0db0db835734bfbaf91b5537f1fd8cb887e"} build_url:https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011513 build_url: 'https://queue.taskcluster.net/v1/task/ePtbxzYOTTiB2D6NQPbWBQ/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/1c357bf72e8c62861f7f8602e2d950fabb8afbfe2adb2676c7fe42f2132ddfbb835b8a324209d5eb4093c4ca11ab50343605eebaeeecac1f9680b6a2962c6bb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/362dbc45cee783d1189b7275e595d66df1648e18a8a9cb8382801100ff8bf6e3e5cde5445b96f208668fcecc78acfe0c1ab692b680e7d681dd78e00e067b98fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b635f7153366ec6ed5ba1f007a8595aab356bd3ae5424b7323fd1de768318c24e04f879b615345ce00fcb3bbd01db0db0db835734bfbaf91b5537f1fd8cb887e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 05:14:37.172302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 05:14:37.172707) ========= 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=62c568580acbfdaac3eec7be000001dc-1480847706.411075-42371595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 05:14:37.255413) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 05:14:37.255793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 05:14:37.256211) ========= ========= Total master_lag: 0.18 =========