builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1477650435.24 results: success (0) buildid: 20161028004017 builduid: ac45770108a94f8bae0d47030c43f04b revision: 4af3cec722c07b291d41f6fd7ba727b17e2cb613 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:15.243487) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:15.244199) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:15.244696) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:15.262818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:15.263171) ========= 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=652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-28 03:27:15-- 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% 50.6M=0s 2016-10-28 03:27:15 (50.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:15.392066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:15.392612) ========= 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=652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018455 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:15.443386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-28 03:27:15.443766) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4af3cec722c07b291d41f6fd7ba727b17e2cb613 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4af3cec722c07b291d41f6fd7ba727b17e2cb613 --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=652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-28 03:27:15,658 truncating revision to first 12 chars 2016-10-28 03:27:15,658 Setting DEBUG logging. 2016-10-28 03:27:15,658 attempt 1/10 2016-10-28 03:27:15,658 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4af3cec722c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 03:27:17,490 unpacking tar archive at: mozilla-aurora-4af3cec722c0/testing/mozharness/ program finished with exit code 0 elapsedTime=2.165567 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-28 03:27:17.622916) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:17.623294) ========= script_repo_revision: 4af3cec722c07b291d41f6fd7ba727b17e2cb613 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:17.623827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:17.624160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 03:27:17.633389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-28 03:27:17.633750) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:17 INFO - MultiFileLogger online at 20161028 03:27:17 in /builds/slave/test 03:27:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:27:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:17 INFO - {'append_to_log': False, 03:27:17 INFO - 'base_work_dir': '/builds/slave/test', 03:27:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:27:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:17 INFO - 'branch': 'Mozilla-Aurora', 03:27:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:17 INFO - 'config_files': ('talos/linux_config.py',), 03:27:17 INFO - 'default_actions': ('clobber', 03:27:17 INFO - 'read-buildbot-config', 03:27:17 INFO - 'download-and-extract', 03:27:17 INFO - 'populate-webroot', 03:27:17 INFO - 'create-virtualenv', 03:27:17 INFO - 'install', 03:27:17 INFO - 'run-tests'), 03:27:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:17 INFO - 'download_minidump_stackwalk': True, 03:27:17 INFO - 'download_symbols': 'ondemand', 03:27:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:17 INFO - 'installer_path': 'installer.exe', 03:27:17 INFO - 'log_level': 'info', 03:27:17 INFO - 'log_name': 'talos', 03:27:17 INFO - 'log_to_console': True, 03:27:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:17 INFO - 'opt_config_files': (), 03:27:17 INFO - 'pip_index': False, 03:27:17 INFO - 'sps_profile': False, 03:27:17 INFO - 'sps_profile_interval': 0, 03:27:17 INFO - 'suite': 'dromaeojs', 03:27:17 INFO - 'system_bits': '32', 03:27:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:17 INFO - 'title': 'talos-linux64-ix-046', 03:27:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:17 INFO - 'use_talos_json': True, 03:27:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:17 INFO - 'work_dir': 'build'} 03:27:17 INFO - [mozharness: 2016-10-28 10:27:17.935976Z] Running clobber step. 03:27:17 INFO - Running pre-action listener: _resource_record_pre_action 03:27:17 INFO - Running main action method: clobber 03:27:17 INFO - rmtree: /builds/slave/test/build 03:27:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:18 INFO - Running post-action listener: _resource_record_post_action 03:27:18 INFO - [mozharness: 2016-10-28 10:27:18.396049Z] Finished clobber step (success) 03:27:18 INFO - [mozharness: 2016-10-28 10:27:18.396150Z] Running read-buildbot-config step. 03:27:18 INFO - Running pre-action listener: _resource_record_pre_action 03:27:18 INFO - Running main action method: read_buildbot_config 03:27:18 INFO - Using buildbot properties: 03:27:18 INFO - { 03:27:18 INFO - "project": "", 03:27:18 INFO - "product": "firefox", 03:27:18 INFO - "script_repo_revision": "production", 03:27:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:27:18 INFO - "repository": "", 03:27:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:27:18 INFO - "buildid": "20161028004017", 03:27:18 INFO - "stage_platform": "linux64-pgo", 03:27:18 INFO - "basedir": "/builds/slave/test", 03:27:18 INFO - "nightly_build": "True", 03:27:18 INFO - "buildnumber": 599, 03:27:18 INFO - "slavename": "talos-linux64-ix-046", 03:27:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:27:18 INFO - "platform": "ubuntu64_hw", 03:27:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:27:18 INFO - "branch": "mozilla-aurora", 03:27:18 INFO - "repo_path": "releases/mozilla-aurora", 03:27:18 INFO - "revision": "4af3cec722c07b291d41f6fd7ba727b17e2cb613", 03:27:18 INFO - "pgo_build": "True", 03:27:18 INFO - "builduid": "ac45770108a94f8bae0d47030c43f04b", 03:27:18 INFO - "slavebuilddir": "test" 03:27:18 INFO - } 03:27:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:27:18 INFO - Running post-action listener: _resource_record_post_action 03:27:18 INFO - [mozharness: 2016-10-28 10:27:18.398658Z] Finished read-buildbot-config step (success) 03:27:18 INFO - [mozharness: 2016-10-28 10:27:18.398748Z] Running download-and-extract step. 03:27:18 INFO - Running pre-action listener: _resource_record_pre_action 03:27:18 INFO - Running main action method: download_and_extract 03:27:18 INFO - mkdir: /builds/slave/test/build/tests 03:27:18 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')]} 03:27:18 INFO - trying https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:27:18 INFO - Downloading https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:27:18 INFO - Downloaded 1361 bytes. 03:27:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:27:18 INFO - Using the following test package requirements: 03:27:18 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:18 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:27:18 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:27:18 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:18 INFO - u'jsshell-linux-x86_64.zip'], 03:27:18 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:27:18 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:18 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:27:18 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:27:18 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:27:18 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:27:18 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:27:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:27:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:27:18 INFO - Fetch https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:27:19 INFO - Expected file size: 21894132 03:27:23 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:27:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:27:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:27:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:27:24 INFO - Expected file size: 21894132 03:27:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:27:29 INFO - Fetch https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:27:29 INFO - Expected file size: 14414081 03:27:30 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')]} 03:27:30 INFO - trying https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:27:30 INFO - Downloading https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:27:31 INFO - Downloaded 63932122 bytes. 03:27:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:27:31 INFO - mkdir: /builds/slave/test/properties 03:27:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:27:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:27:31 INFO - Contents: 03:27:31 INFO - build_url:https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:27:32 INFO - Running post-action listener: _resource_record_post_action 03:27:32 INFO - Running post-action listener: set_extra_try_arguments 03:27:32 INFO - [mozharness: 2016-10-28 10:27:32.086358Z] Finished download-and-extract step (success) 03:27:32 INFO - [mozharness: 2016-10-28 10:27:32.086585Z] Running populate-webroot step. 03:27:32 INFO - Running pre-action listener: _resource_record_pre_action 03:27:32 INFO - Running main action method: populate_webroot 03:27:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:27:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:27:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:27:32 INFO - '--tppagecycles', 03:27:32 INFO - '7'], 03:27:32 INFO - 'tests': ['tsvgm']}}, 03:27:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:27:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:27:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:27:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:27:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:32 INFO - 'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:32 INFO - 'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['damp', 'tps']}, 03:27:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:32 INFO - 'tests': ['damp', 'tps']}, 03:27:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['dromaeo_dom']}, 03:27:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:27:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['basic_compositor_video']}, 03:27:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:27:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['a11yr', 03:27:32 INFO - 'ts_paint', 03:27:32 INFO - 'tpaint', 03:27:32 INFO - 'sessionrestore', 03:27:32 INFO - 'sessionrestore_no_auto_restore', 03:27:32 INFO - 'tabpaint']}, 03:27:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:27:32 INFO - 'ts_paint', 03:27:32 INFO - 'tpaint', 03:27:32 INFO - 'sessionrestore', 03:27:32 INFO - 'sessionrestore_no_auto_restore', 03:27:32 INFO - 'tabpaint']}, 03:27:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:27:32 INFO - 'ts_paint', 03:27:32 INFO - 'tpaint', 03:27:32 INFO - 'sessionrestore', 03:27:32 INFO - 'sessionrestore_no_auto_restore', 03:27:32 INFO - 'tabpaint']}, 03:27:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:27:32 INFO - 'ts_paint', 03:27:32 INFO - 'tpaint', 03:27:32 INFO - 'sessionrestore', 03:27:32 INFO - 'sessionrestore_no_auto_restore', 03:27:32 INFO - 'tabpaint']}, 03:27:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['a11yr', 03:27:32 INFO - 'ts_paint', 03:27:32 INFO - 'tpaint', 03:27:32 INFO - 'sessionrestore', 03:27:32 INFO - 'sessionrestore_no_auto_restore', 03:27:32 INFO - 'tabpaint']}, 03:27:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['a11yr', 03:27:32 INFO - 'ts_paint', 03:27:32 INFO - 'tpaint', 03:27:32 INFO - 'sessionrestore', 03:27:32 INFO - 'sessionrestore_no_auto_restore', 03:27:32 INFO - 'tabpaint']}, 03:27:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['tsvgx', 03:27:32 INFO - 'tsvgr_opacity', 03:27:32 INFO - 'tart', 03:27:32 INFO - 'tscrollx', 03:27:32 INFO - 'cart']}, 03:27:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:27:32 INFO - 'tsvgr_opacity', 03:27:32 INFO - 'tart', 03:27:32 INFO - 'tscrollx', 03:27:32 INFO - 'cart']}, 03:27:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:32 INFO - 'talos_options': ['--disable-e10s'], 03:27:32 INFO - 'tests': ['tp5o']}, 03:27:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:32 INFO - 'tests': ['tp5o']}, 03:27:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:32 INFO - 'talos_options': ['--disable-e10s', 03:27:32 INFO - '--xperf_path', 03:27:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:32 INFO - 'tests': ['tp5n']}, 03:27:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:32 INFO - 'talos_options': ['--xperf_path', 03:27:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:32 INFO - 'tests': ['tp5n']}}, 03:27:32 INFO - 'talos.zip': {'path': '', 03:27:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:27:32 INFO - Running post-action listener: _resource_record_post_action 03:27:32 INFO - [mozharness: 2016-10-28 10:27:32.104069Z] Finished populate-webroot step (success) 03:27:32 INFO - [mozharness: 2016-10-28 10:27:32.104157Z] Running create-virtualenv step. 03:27:32 INFO - Running pre-action listener: _resource_record_pre_action 03:27:32 INFO - Running main action method: create_virtualenv 03:27:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:27:32 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 03:27:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:27:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:27:32 INFO - Using real prefix '/usr' 03:27:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:27:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:34 INFO - Installing pip.................done. 03:27:34 INFO - Return code: 0 03:27:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27:34 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')]} 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:34 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')]} 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:34 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 0x7f6f78708f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c76ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', '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 03:27:34 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 03:27:34 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 03:27:34 INFO - Using env: {'DISPLAY': ':0', 03:27:34 INFO - 'HOME': '/home/cltbld', 03:27:34 INFO - 'LANG': 'en_US.UTF-8', 03:27:34 INFO - 'LANGUAGE': 'en_US:en', 03:27:34 INFO - 'LOGNAME': 'cltbld', 03:27:34 INFO - 'MAIL': '/var/mail/cltbld', 03:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:34 INFO - 'MOZ_NO_REMOTE': '1', 03:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:34 INFO - 'NO_EM_RESTART': '1', 03:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:34 INFO - 'PWD': '/builds/slave/test', 03:27:34 INFO - 'SHELL': '/bin/bash', 03:27:34 INFO - 'SHLVL': '1', 03:27:34 INFO - 'TERM': 'linux', 03:27:34 INFO - 'TMOUT': '86400', 03:27:34 INFO - 'USER': 'cltbld', 03:27:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:34 INFO - '_': '/tools/buildbot/bin/python'} 03:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:34 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 03:27:34 INFO - Cleaning up... 03:27:34 INFO - Return code: 0 03:27:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:27:34 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')]} 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:34 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')]} 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:34 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 0x7f6f78708f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c76ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', '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 03:27:34 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 03:27:34 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 03:27:34 INFO - Using env: {'DISPLAY': ':0', 03:27:34 INFO - 'HOME': '/home/cltbld', 03:27:34 INFO - 'LANG': 'en_US.UTF-8', 03:27:34 INFO - 'LANGUAGE': 'en_US:en', 03:27:34 INFO - 'LOGNAME': 'cltbld', 03:27:34 INFO - 'MAIL': '/var/mail/cltbld', 03:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:34 INFO - 'MOZ_NO_REMOTE': '1', 03:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:34 INFO - 'NO_EM_RESTART': '1', 03:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:34 INFO - 'PWD': '/builds/slave/test', 03:27:34 INFO - 'SHELL': '/bin/bash', 03:27:34 INFO - 'SHLVL': '1', 03:27:34 INFO - 'TERM': 'linux', 03:27:34 INFO - 'TMOUT': '86400', 03:27:34 INFO - 'USER': 'cltbld', 03:27:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:34 INFO - '_': '/tools/buildbot/bin/python'} 03:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:35 INFO - Downloading/unpacking psutil>=3.1.1 03:27:35 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 03:27:35 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 03:27:35 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 03:27:35 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 03:27:35 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 03:27:35 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 03:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:37 INFO - Installing collected packages: psutil 03:27:37 INFO - Running setup.py install for psutil 03:27:37 INFO - building 'psutil._psutil_linux' extension 03:27:37 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 03:27:37 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 03:27:37 INFO - building 'psutil._psutil_posix' extension 03:27:37 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 03:27:37 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 03:27:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:37 INFO - Successfully installed psutil 03:27:37 INFO - Cleaning up... 03:27:37 INFO - Return code: 0 03:27:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f78708f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c76ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', '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 03:27:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:27:37 INFO - Using env: {'DISPLAY': ':0', 03:27:37 INFO - 'HOME': '/home/cltbld', 03:27:37 INFO - 'LANG': 'en_US.UTF-8', 03:27:37 INFO - 'LANGUAGE': 'en_US:en', 03:27:37 INFO - 'LOGNAME': 'cltbld', 03:27:37 INFO - 'MAIL': '/var/mail/cltbld', 03:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:37 INFO - 'MOZ_NO_REMOTE': '1', 03:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:37 INFO - 'NO_EM_RESTART': '1', 03:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:37 INFO - 'PWD': '/builds/slave/test', 03:27:37 INFO - 'SHELL': '/bin/bash', 03:27:37 INFO - 'SHLVL': '1', 03:27:37 INFO - 'TERM': 'linux', 03:27:37 INFO - 'TMOUT': '86400', 03:27:37 INFO - 'USER': 'cltbld', 03:27:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:37 INFO - '_': '/tools/buildbot/bin/python'} 03:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:27:39 INFO - Installing collected packages: mozsystemmonitor 03:27:39 INFO - Running setup.py install for mozsystemmonitor 03:27:40 INFO - Successfully installed mozsystemmonitor 03:27:40 INFO - Cleaning up... 03:27:40 INFO - Return code: 0 03:27:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:27:40 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')]} 03:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:40 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')]} 03:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:40 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 0x7f6f78708f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c76ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', '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 03:27:40 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 03:27:40 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 03:27:40 INFO - Using env: {'DISPLAY': ':0', 03:27:40 INFO - 'HOME': '/home/cltbld', 03:27:40 INFO - 'LANG': 'en_US.UTF-8', 03:27:40 INFO - 'LANGUAGE': 'en_US:en', 03:27:40 INFO - 'LOGNAME': 'cltbld', 03:27:40 INFO - 'MAIL': '/var/mail/cltbld', 03:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:40 INFO - 'MOZ_NO_REMOTE': '1', 03:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:40 INFO - 'NO_EM_RESTART': '1', 03:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:40 INFO - 'PWD': '/builds/slave/test', 03:27:40 INFO - 'SHELL': '/bin/bash', 03:27:40 INFO - 'SHLVL': '1', 03:27:40 INFO - 'TERM': 'linux', 03:27:40 INFO - 'TMOUT': '86400', 03:27:40 INFO - 'USER': 'cltbld', 03:27:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:40 INFO - '_': '/tools/buildbot/bin/python'} 03:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:40 INFO - Downloading/unpacking jsonschema==2.5.1 03:27:40 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 03:27:40 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 03:27:40 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 03:27:40 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 03:27:40 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 03:27:40 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 03:27:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:27:42 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 03:27:42 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 03:27:42 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 03:27:42 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 03:27:42 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 03:27:42 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 03:27:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:42 INFO - warning: no files found matching '*.txt' 03:27:42 INFO - no previously-included directories found matching 'build' 03:27:42 INFO - no previously-included directories found matching 'dist' 03:27:42 INFO - no previously-included directories found matching '.git*' 03:27:42 INFO - Installing collected packages: jsonschema, functools32 03:27:42 INFO - Running setup.py install for functools32 03:27:42 INFO - warning: no files found matching '*.txt' 03:27:42 INFO - no previously-included directories found matching 'build' 03:27:42 INFO - no previously-included directories found matching 'dist' 03:27:42 INFO - no previously-included directories found matching '.git*' 03:27:42 INFO - Successfully installed jsonschema functools32 03:27:42 INFO - Cleaning up... 03:27:42 INFO - Return code: 0 03:27:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:27:42 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')]} 03:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:42 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')]} 03:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:42 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 0x7f6f78708f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c76ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', '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 03:27:42 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 03:27:42 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 03:27:42 INFO - Using env: {'DISPLAY': ':0', 03:27:42 INFO - 'HOME': '/home/cltbld', 03:27:42 INFO - 'LANG': 'en_US.UTF-8', 03:27:42 INFO - 'LANGUAGE': 'en_US:en', 03:27:42 INFO - 'LOGNAME': 'cltbld', 03:27:42 INFO - 'MAIL': '/var/mail/cltbld', 03:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:42 INFO - 'MOZ_NO_REMOTE': '1', 03:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:42 INFO - 'NO_EM_RESTART': '1', 03:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:42 INFO - 'PWD': '/builds/slave/test', 03:27:42 INFO - 'SHELL': '/bin/bash', 03:27:42 INFO - 'SHLVL': '1', 03:27:42 INFO - 'TERM': 'linux', 03:27:42 INFO - 'TMOUT': '86400', 03:27:42 INFO - 'USER': 'cltbld', 03:27:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:42 INFO - '_': '/tools/buildbot/bin/python'} 03:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:27:42 INFO - Cleaning up... 03:27:42 INFO - Return code: 0 03:27:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:27:42 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')]} 03:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:42 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')]} 03:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:42 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 0x7f6f78708f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c76ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', '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 03:27:42 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 03:27:42 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 03:27:42 INFO - Using env: {'DISPLAY': ':0', 03:27:42 INFO - 'HOME': '/home/cltbld', 03:27:42 INFO - 'LANG': 'en_US.UTF-8', 03:27:42 INFO - 'LANGUAGE': 'en_US:en', 03:27:42 INFO - 'LOGNAME': 'cltbld', 03:27:42 INFO - 'MAIL': '/var/mail/cltbld', 03:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:42 INFO - 'MOZ_NO_REMOTE': '1', 03:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:42 INFO - 'NO_EM_RESTART': '1', 03:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:42 INFO - 'PWD': '/builds/slave/test', 03:27:42 INFO - 'SHELL': '/bin/bash', 03:27:42 INFO - 'SHLVL': '1', 03:27:42 INFO - 'TERM': 'linux', 03:27:42 INFO - 'TMOUT': '86400', 03:27:42 INFO - 'USER': 'cltbld', 03:27:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:42 INFO - '_': '/tools/buildbot/bin/python'} 03:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:43 INFO - Downloading/unpacking blobuploader==1.2.4 03:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:45 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 03:27:45 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 03:27:45 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 03:27:45 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 03:27:45 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 03:27:45 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 03:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27:45 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 03:27:45 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 03:27:45 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 03:27:45 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 03:27:45 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 03:27:45 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 03:27:45 INFO - Downloading docopt-0.6.1.tar.gz 03:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:45 INFO - Running setup.py install for blobuploader 03:27:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:45 INFO - Running setup.py install for requests 03:27:46 INFO - Running setup.py install for docopt 03:27:46 INFO - Successfully installed blobuploader requests docopt 03:27:46 INFO - Cleaning up... 03:27:46 INFO - Return code: 0 03:27:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:46 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 0x7f6f78708f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c76ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', '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 03:27:46 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 03:27:46 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 03:27:46 INFO - Using env: {'DISPLAY': ':0', 03:27:46 INFO - 'HOME': '/home/cltbld', 03:27:46 INFO - 'LANG': 'en_US.UTF-8', 03:27:46 INFO - 'LANGUAGE': 'en_US:en', 03:27:46 INFO - 'LOGNAME': 'cltbld', 03:27:46 INFO - 'MAIL': '/var/mail/cltbld', 03:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:46 INFO - 'MOZ_NO_REMOTE': '1', 03:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:46 INFO - 'NO_EM_RESTART': '1', 03:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:46 INFO - 'PWD': '/builds/slave/test', 03:27:46 INFO - 'SHELL': '/bin/bash', 03:27:46 INFO - 'SHLVL': '1', 03:27:46 INFO - 'TERM': 'linux', 03:27:46 INFO - 'TMOUT': '86400', 03:27:46 INFO - 'USER': 'cltbld', 03:27:46 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:46 INFO - '_': '/tools/buildbot/bin/python'} 03:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:46 INFO - Running setup.py (path:/tmp/pip-c6MfxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:46 INFO - Running setup.py (path:/tmp/pip-XevCMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:46 INFO - Running setup.py (path:/tmp/pip-Uy_rHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:46 INFO - Running setup.py (path:/tmp/pip-6UF12z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:46 INFO - Running setup.py (path:/tmp/pip-3imvYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:47 INFO - Running setup.py (path:/tmp/pip-ttlSxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:47 INFO - Running setup.py (path:/tmp/pip-QgBGSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:47 INFO - Running setup.py (path:/tmp/pip-4jZ7li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:47 INFO - Running setup.py (path:/tmp/pip-YAoULF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:47 INFO - Running setup.py (path:/tmp/pip-qBxiWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:47 INFO - Running setup.py (path:/tmp/pip-JGBkNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:47 INFO - Running setup.py (path:/tmp/pip-V7ZctC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:47 INFO - Running setup.py (path:/tmp/pip-24sZhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:47 INFO - Running setup.py (path:/tmp/pip-6MGqPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:47 INFO - Running setup.py (path:/tmp/pip-lkNrg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:47 INFO - Running setup.py (path:/tmp/pip-T5CWz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:47 INFO - Running setup.py (path:/tmp/pip-GUnpeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:47 INFO - Running setup.py install for manifestparser 03:27:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:47 INFO - Running setup.py install for mozcrash 03:27:48 INFO - Running setup.py install for mozdebug 03:27:48 INFO - Running setup.py install for mozdevice 03:27:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:27:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:48 INFO - Running setup.py install for mozfile 03:27:48 INFO - Running setup.py install for mozhttpd 03:27:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:48 INFO - Running setup.py install for mozinfo 03:27:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:48 INFO - Running setup.py install for mozInstall 03:27:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:48 INFO - Running setup.py install for mozleak 03:27:48 INFO - Running setup.py install for mozlog 03:27:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:48 INFO - Running setup.py install for moznetwork 03:27:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:49 INFO - Running setup.py install for mozprocess 03:27:49 INFO - Running setup.py install for mozprofile 03:27:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:49 INFO - Running setup.py install for mozrunner 03:27:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:49 INFO - Running setup.py install for mozscreenshot 03:27:49 INFO - Running setup.py install for moztest 03:27:49 INFO - Running setup.py install for mozversion 03:27:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:49 INFO - Cleaning up... 03:27:49 INFO - Return code: 0 03:27:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:49 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 0x7f6f78708f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c76ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', '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 03:27:49 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 03:27:49 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 03:27:49 INFO - Using env: {'DISPLAY': ':0', 03:27:49 INFO - 'HOME': '/home/cltbld', 03:27:49 INFO - 'LANG': 'en_US.UTF-8', 03:27:49 INFO - 'LANGUAGE': 'en_US:en', 03:27:49 INFO - 'LOGNAME': 'cltbld', 03:27:49 INFO - 'MAIL': '/var/mail/cltbld', 03:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:49 INFO - 'MOZ_NO_REMOTE': '1', 03:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:49 INFO - 'NO_EM_RESTART': '1', 03:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:49 INFO - 'PWD': '/builds/slave/test', 03:27:49 INFO - 'SHELL': '/bin/bash', 03:27:49 INFO - 'SHLVL': '1', 03:27:49 INFO - 'TERM': 'linux', 03:27:49 INFO - 'TMOUT': '86400', 03:27:49 INFO - 'USER': 'cltbld', 03:27:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:49 INFO - '_': '/tools/buildbot/bin/python'} 03:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:49 INFO - Running setup.py (path:/tmp/pip-j57RPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:49 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)) 03:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:49 INFO - Running setup.py (path:/tmp/pip-z1I364-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:50 INFO - Running setup.py (path:/tmp/pip-cPU5AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:50 INFO - Running setup.py (path:/tmp/pip-kCOrRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:50 INFO - Running setup.py (path:/tmp/pip-RoXtMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:50 INFO - Running setup.py (path:/tmp/pip-2iWJJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:50 INFO - Running setup.py (path:/tmp/pip-a6u4DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:50 INFO - Running setup.py (path:/tmp/pip-n470f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:50 INFO - Running setup.py (path:/tmp/pip-jAMjQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:50 INFO - Running setup.py (path:/tmp/pip-ew36ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:50 INFO - Running setup.py (path:/tmp/pip-DE4aay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:50 INFO - Running setup.py (path:/tmp/pip-lktJT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:50 INFO - Running setup.py (path:/tmp/pip-MbPDUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:50 INFO - Running setup.py (path:/tmp/pip-L68JGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:50 INFO - Running setup.py (path:/tmp/pip-QGlvDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:50 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)) 03:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:50 INFO - Running setup.py (path:/tmp/pip-7MKbfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:51 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)) 03:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:51 INFO - Running setup.py (path:/tmp/pip-LRCl83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:51 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)) 03:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:27:51 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)) 03:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:27:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:51 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 03:27:51 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 03:27:51 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 03:27:51 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 03:27:51 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 03:27:51 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 03:27:53 INFO - Downloading blessings-1.6.tar.gz 03:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:53 INFO - Installing collected packages: blessings 03:27:53 INFO - Running setup.py install for blessings 03:27:53 INFO - Successfully installed blessings 03:27:53 INFO - Cleaning up... 03:27:53 INFO - Return code: 0 03:27:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:53 INFO - Reading from file tmpfile_stdout 03:27:53 INFO - Current package versions: 03:27:53 INFO - argparse == 1.2.1 03:27:53 INFO - blessings == 1.6 03:27:53 INFO - blobuploader == 1.2.4 03:27:53 INFO - docopt == 0.6.1 03:27:53 INFO - functools32 == 3.2.3-2 03:27:53 INFO - jsonschema == 2.5.1 03:27:53 INFO - manifestparser == 1.1 03:27:53 INFO - mozInstall == 1.12 03:27:53 INFO - mozcrash == 0.17 03:27:53 INFO - mozdebug == 0.1 03:27:53 INFO - mozdevice == 0.48 03:27:53 INFO - mozfile == 1.2 03:27:53 INFO - mozhttpd == 0.7 03:27:53 INFO - mozinfo == 0.9 03:27:53 INFO - mozleak == 0.1 03:27:53 INFO - mozlog == 3.4 03:27:53 INFO - moznetwork == 0.27 03:27:53 INFO - mozprocess == 0.23 03:27:53 INFO - mozprofile == 0.28 03:27:53 INFO - mozrunner == 6.12 03:27:53 INFO - mozscreenshot == 0.1 03:27:53 INFO - mozsystemmonitor == 0.3 03:27:53 INFO - moztest == 0.7 03:27:53 INFO - mozversion == 1.4 03:27:53 INFO - psutil == 3.1.1 03:27:53 INFO - requests == 1.2.3 03:27:53 INFO - wsgiref == 0.1.2 03:27:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:53 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 0x7f6f78708f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c76ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', '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 03:27:53 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 03:27:53 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 03:27:53 INFO - Using env: {'DISPLAY': ':0', 03:27:53 INFO - 'HOME': '/home/cltbld', 03:27:53 INFO - 'LANG': 'en_US.UTF-8', 03:27:53 INFO - 'LANGUAGE': 'en_US:en', 03:27:53 INFO - 'LOGNAME': 'cltbld', 03:27:53 INFO - 'MAIL': '/var/mail/cltbld', 03:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:53 INFO - 'MOZ_NO_REMOTE': '1', 03:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:53 INFO - 'NO_EM_RESTART': '1', 03:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:53 INFO - 'PWD': '/builds/slave/test', 03:27:53 INFO - 'SHELL': '/bin/bash', 03:27:53 INFO - 'SHLVL': '1', 03:27:53 INFO - 'TERM': 'linux', 03:27:53 INFO - 'TMOUT': '86400', 03:27:53 INFO - 'USER': 'cltbld', 03:27:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:53 INFO - '_': '/tools/buildbot/bin/python'} 03:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:53 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)) 03:27:53 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)) 03:27:53 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)) 03:27:53 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)) 03:27:53 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)) 03:27:53 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)) 03:27:53 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)) 03:27:53 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)) 03:27:53 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)) 03:27:53 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)) 03:27:53 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)) 03:27:53 INFO - Cleaning up... 03:27:53 INFO - Return code: 0 03:27:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:53 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 0x7f6f78708f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c76ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', '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 03:27:53 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 03:27:53 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 03:27:53 INFO - Using env: {'DISPLAY': ':0', 03:27:53 INFO - 'HOME': '/home/cltbld', 03:27:53 INFO - 'LANG': 'en_US.UTF-8', 03:27:53 INFO - 'LANGUAGE': 'en_US:en', 03:27:53 INFO - 'LOGNAME': 'cltbld', 03:27:53 INFO - 'MAIL': '/var/mail/cltbld', 03:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:53 INFO - 'MOZ_NO_REMOTE': '1', 03:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:53 INFO - 'NO_EM_RESTART': '1', 03:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:53 INFO - 'PWD': '/builds/slave/test', 03:27:53 INFO - 'SHELL': '/bin/bash', 03:27:53 INFO - 'SHLVL': '1', 03:27:53 INFO - 'TERM': 'linux', 03:27:53 INFO - 'TMOUT': '86400', 03:27:53 INFO - 'USER': 'cltbld', 03:27:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:53 INFO - '_': '/tools/buildbot/bin/python'} 03:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:53 INFO - Cleaning up... 03:27:54 INFO - Return code: 0 03:27:54 INFO - Running post-action listener: _resource_record_post_action 03:27:54 INFO - Running post-action listener: _start_resource_monitoring 03:27:54 INFO - Starting resource monitoring. 03:27:54 INFO - [mozharness: 2016-10-28 10:27:54.032996Z] Finished create-virtualenv step (success) 03:27:54 INFO - [mozharness: 2016-10-28 10:27:54.033565Z] Running install step. 03:27:54 INFO - Running pre-action listener: _resource_record_pre_action 03:27:54 INFO - Running main action method: install 03:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:54 INFO - Reading from file tmpfile_stdout 03:27:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:54 INFO - Reading from file tmpfile_stdout 03:27:54 INFO - Output received: 03:27:54 INFO - Usage: mozinstall [options] installer 03:27:54 INFO - Options: 03:27:54 INFO - -h, --help show this help message and exit 03:27:54 INFO - -d DEST, --destination=DEST 03:27:54 INFO - Directory to install application into. [default: 03:27:54 INFO - "/builds/slave/test"] 03:27:54 INFO - --app=APP Application being installed. [default: firefox] 03:27:54 INFO - mkdir: /builds/slave/test/build/application 03:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:28:10 INFO - Reading from file tmpfile_stdout 03:28:10 INFO - Output received: 03:28:10 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:10 INFO - Running post-action listener: _resource_record_post_action 03:28:10 INFO - [mozharness: 2016-10-28 10:28:10.297737Z] Finished install step (success) 03:28:10 INFO - [mozharness: 2016-10-28 10:28:10.297982Z] Running run-tests step. 03:28:10 INFO - Running pre-action listener: _resource_record_pre_action 03:28:10 INFO - Running main action method: run_tests 03:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:10 INFO - Python 2.7.3 03:28:10 INFO - Return code: 0 03:28:10 INFO - grabbing minidump binary from tooltool 03:28:10 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')]} 03:28:10 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 0x2c73f60>, '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 0x2c74d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c751d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:10 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 03:28:10 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 03:28:10 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 03:28:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:10 INFO - Return code: 0 03:28:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 03:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 03:28:10 INFO - Using env: {'DISPLAY': ':0', 03:28:10 INFO - 'HOME': '/home/cltbld', 03:28:10 INFO - 'LANG': 'en_US.UTF-8', 03:28:10 INFO - 'LANGUAGE': 'en_US:en', 03:28:10 INFO - 'LOGNAME': 'cltbld', 03:28:10 INFO - 'MAIL': '/var/mail/cltbld', 03:28:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:10 INFO - 'MOZ_NO_REMOTE': '1', 03:28:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:10 INFO - 'NO_EM_RESTART': '1', 03:28:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:10 INFO - 'PWD': '/builds/slave/test', 03:28:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:10 INFO - 'SHELL': '/bin/bash', 03:28:10 INFO - 'SHLVL': '1', 03:28:10 INFO - 'TERM': 'linux', 03:28:10 INFO - 'TMOUT': '86400', 03:28:10 INFO - 'USER': 'cltbld', 03:28:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261', 03:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:10 INFO - '_': '/tools/buildbot/bin/python'} 03:28:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 03:28:10 INFO - mozversion application_buildid: 20161028004017 03:28:10 INFO - mozversion application_changeset: 4af3cec722c07b291d41f6fd7ba727b17e2cb613 03:28:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:28:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:10 INFO - mozversion application_name: Firefox 03:28:10 INFO - mozversion application_remotingname: firefox-dev 03:28:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:10 INFO - mozversion application_vendor: Mozilla 03:28:10 INFO - mozversion application_version: 51.0a2 03:28:10 INFO - mozversion platform_buildid: 20161028004017 03:28:10 INFO - mozversion platform_changeset: 4af3cec722c07b291d41f6fd7ba727b17e2cb613 03:28:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:10 INFO - mozversion platform_version: 51.0a2 03:28:10 INFO - using testdate: 1477650490 03:28:10 INFO - actual date: 1477650490 03:28:10 INFO - starting webserver on 'localhost:49140' 03:28:10 INFO - SUITE-START | Running 2 tests 03:28:10 INFO - TEST-START | dromaeo_css 03:28:10 INFO - operating with platform_type : linux_ 03:28:10 INFO - Initialising browser for dromaeo_css test... 03:28:10 INFO - TEST-INFO | started process 7188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKC5ZEB/profile http://localhost:49140/getInfo.html) 03:28:14 INFO - PROCESS | 7188 | __metrics Screen width/height:1600/1200 03:28:14 INFO - PROCESS | 7188 | colorDepth:24 03:28:14 INFO - PROCESS | 7188 | Browser inner width/height: 1024/697 03:28:14 INFO - PROCESS | 7188 | __metrics 03:28:15 INFO - PROCESS | 7188 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:28:15 INFO - PROCESS | 7188 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:28:15 INFO - PROCESS | 7188 | console.error: PushService: 03:28:15 INFO - PROCESS | 7188 | stateChangeProcessEnqueue: Error transitioning state 03:28:15 INFO - PROCESS | 7188 | UnknownError 03:28:16 INFO - TEST-INFO | 7188: exit 0 03:28:16 INFO - Browser initialized. 03:28:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:16 INFO - TEST-INFO | started process 7282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKC5ZEB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:28 INFO - PROCESS | 7282 | RSS: Main: 144498688 03:28:28 INFO - PROCESS | 7282 | 03:29:19 INFO - PROCESS | 7282 | 1477650559455 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] 03:31:28 INFO - PROCESS | 7282 | Cycle 1(1): loaded http://localhost:49140/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49140/tests/dromaeo/cssquery-ext.html) 03:31:29 INFO - PROCESS | 7282 | RSS: Main: 245772288 03:31:29 INFO - PROCESS | 7282 | 03:34:32 INFO - PROCESS | 7282 | Cycle 1(1): loaded http://localhost:49140/tests/dromaeo/cssquery-ext.html (next: http://localhost:49140/tests/dromaeo/cssquery-jquery.html) 03:34:32 INFO - PROCESS | 7282 | RSS: Main: 234827776 03:34:32 INFO - PROCESS | 7282 | 03:37:34 INFO - PROCESS | 7282 | Cycle 1(1): loaded http://localhost:49140/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49140/tests/dromaeo/cssquery-mootools.html) 03:37:35 INFO - PROCESS | 7282 | RSS: Main: 174809088 03:37:35 INFO - PROCESS | 7282 | 03:40:37 INFO - PROCESS | 7282 | Cycle 1(1): loaded http://localhost:49140/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49140/tests/dromaeo/cssquery-prototype.html) 03:40:37 INFO - PROCESS | 7282 | RSS: Main: 215941120 03:40:37 INFO - PROCESS | 7282 | 03:43:40 INFO - PROCESS | 7282 | Cycle 1(1): loaded http://localhost:49140/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49140/tests/dromaeo/cssquery-yui.html) 03:43:40 INFO - PROCESS | 7282 | RSS: Main: 176484352 03:43:40 INFO - PROCESS | 7282 | 03:46:43 INFO - PROCESS | 7282 | Cycle 1(1): loaded http://localhost:49140/tests/dromaeo/cssquery-yui.html (next: http://localhost:49140/tests/dromaeo/cssquery-dojo.html) 03:46:43 INFO - PROCESS | 7282 | RSS: Main: 264343552 03:46:43 INFO - PROCESS | 7282 | 03:46:43 INFO - PROCESS | 7282 | __start_tp_report 03:46:43 INFO - PROCESS | 7282 | _x_x_mozilla_page_load 03:46:43 INFO - PROCESS | 7282 | _x_x_mozilla_page_load_details 03:46:43 INFO - PROCESS | 7282 | |i|pagename|runs| 03:46:43 INFO - PROCESS | 7282 | |0;dojo.html;3135.4199473097474;3171.0328349853285;3182.124915648198;3204.887828925988;3223.4681277589198;5490.341159060913;5546.223528705985;5559.805406810762;5577.330720313568;5578.944210557893;5557.055300598898;5607.523360514361;5621.80323688671;5628.26832511774;5644.181593668915;5048.217526283432;5063.291139240509;5099.949000509984;5136.049830781299;5143.691378517282;4939;5116.437191908887;5163.793448262084;5176.0683077046115;5178.741062946838;4895.167821470341;4971.825986090469;5004.474530174334;5008.524190201925;5042.4201216860165;5072.949270507284;5101.056304583645;5103.311053007834;5165.147750621143;5200.115980283361;4862.3922009748785;5040.873978150539;5069.391672999263;5120.334356533627;5132.204508301182;5425.213344065128;5454.59090568209;5455.699936503491;5461.863453413656;5537.418571050022;5900.675462849542;5911.408859114097;5958.463738263534;5964.552658550582;5998.310194327664;5791.594588378815;6021.6085954413265;6022.5483088768515;6023.759049638009;6027.306859711145;5442.156465747816;5516.7517461714315;5577.860553486114;5581.74882130301;5605.0751625982075;6126.969365153235;6152.938470615326;6155.6614386209185;6156.538259630456;6163.3528479509005;5745.683987380734;5921.496672782861;5921.73352199152;5925.05199168131;5925.34821169671;5823.79616713413;5861.648301101863;5862.944669959448;5880.970595147082;5965.940340596625;5846.503047240947;5848.327442344185;5906.232189815297;5907.375471745218;5937.910931336033;5801.796937107265;5849.61977471463;5879.706014699248;5916.23088998436;5917.792877249276;4472.731636101845;4503.234450143484;4540.500544940054;4578.198815207392;4597.609203217764;4087.2029954159248;4098.5286692030795;4099.221147981874;4101.282275601758;4114.855980040744;5647.322321321468;5658.575606829504;5658.943410565842;5663.348714897839;5666.46168613981;5744.942550574524;5784.50831679312;5893.02765043763;5931.288245410492;5985.640861548234;5649.067903795828;5668;5692.48767610917;5694.032014557535;5729.598928074995;5191.351081114861;5199;5201.479852014844;5203.765830537635;5237.764300606482;5867.354590994902;5896.321922978912;6104.694765261808;6193.473554747897;6203.906941395882;5970.940290597038;6021.217241758543;6027.427394397525;6058.606190597597;6068.332483426908;6193.532988916664;6215.316315205414;6221.3156552778255;6225.22184726891;6226.501879849692;5689.715514224355;5702.429757024264;5899.203607512931;5939.346671866005;5939.851503712442;5813.476787089013;5871.647701137946;5878.647281163144;5942.762289508371;5975.55183361241;5791.768329266951;5794.62334948227;5795.768169273182;5799.797007104731;5802.245708057925;5585.748641311069;5787.102999035156;5788.27646544182;5791.044477661138;5792.073268277056;5547.140193270049;5751.1373294006235;5768.682722450138;5804.6807425590305;5889.823305300848;5804.65172089676;5895.852603684943;5899.439553242435;5906.438888305604;5908.911366329595;5595.832125036255;5640.661560306395;5745.770169193353;5751.338596061507;5764.337101233412 03:46:43 INFO - PROCESS | 7282 | |1;ext.html;582.0919365789366;597.259398346051;614.8309214965884;627.654789865574;642.9774957876475;34995.650043499554;45926.31110533344;46616.76691616541;46701;50984;48878;49232.261516077284;49297.50702492974;49396.50603493964;49396.75301623487;8449.704260350889;9368.859467107999;9505.52472376382;9526.761830954212;9531.428114313163;8440.788980275482;10981.670549883516;11275.548978040868;11282.435878206097;11655.125865560118;11333;11333.093352531778;11335.489902954387;11345.092392608612;11386.715332116722;11024.118070554336;11216.102711783078;11217.439128043565;11220.719482012933;11247.606333778278;11132.10943124548;11198.440077996067;11199.552017919274;11205.66383008511;11207.159463040223;46370.07259854784;46583;46767.53232467666;46767.53232467666;46779.298310525366;3800.3159431302356;3811;3863.497745293094;4124.13393187431;4437.312216606431;34636.307273854385;35252.47121293183;35285.64714352849;36676.44985325222;36989.63010369889;4153.439285696422;4173.10278290166;4349.260625693608;4391.890202744957;4412.602865742098;378192;378692;385014.07492962637;385127;385426;39380.60619393826;64251;64655.67672161609;64680.67659661765;64707;39752.60247397547;41675.791621042306;41721;41726;41757.791211043754;17462.738058928873;17697.29210831578;17701.734473982902;17721.113944302735;17730.113494325233;13604.65988350299;13950.372233249325;13959.441622335196;14072.2963851807;14522.273886305642;9368.531573421302;9701.805963880683;9726.659566915125;9731.124198821999;9799.11807937289;3682.742208045411;3686.889393318205;3691.1694868654877;3701.981490092532;3735.9439608405896;1064.6539874540806;1093.136422226448;1113.3798395190445;1115.7935781880378;1236.758832027764;33984.15039624029;33991;34280.82859585736;34551.4817277741;34655.30689386198;1155.6706338693432;1221.1390969366576;1225.7364666596725;1309.2194615323153;1321.4449931028992;17996.280148794165;18053.819461805477;18150.81849181518;18363.17365718546;18458;155460;155911.22044389707;157129;157549.212253938;157655;63521.68239158775;64079.679601601696;64115.67942160353;64122.35877641257;64283.35716642867;1331.3476396565807;1362.5844117544045;1422.9619761808613;1444.8193975753031;1472.7834608913731;30430.84784576063;34266.486002709484;35502.64497355097;35531.28937421289;35854.10364740902;61575.07637385353;62594.374056260676;62654.68672656608;62923.6853815728;62974;534575;536652;537922;539605;540080;46698;47542.28686569774;48264.517354826;48559.5144048555;48560.757196213795;52004.739976299876;52184.47815521796;52630.73684631552;52699.736501317246;52863.207051893485;44062.77968610136;44070.77964610285;44537;45555.316670250635;46313;44745.31528108324;45078.32382514199;45927.540724593666;46128.308075379566;46575.53424465848;44326.55673443224;44873.55126448694;45685.54314456813;45814.541854581024;45841.54158458373;35887.46168807522;38872.805635971636;39229.41155882607;39422.80288598539;39776.20447590974;29318.534073295825;29759.40481190321;29814.254643633216;30228.09315720532;30251.243718907204 03:46:43 INFO - PROCESS | 7282 | |2;jquery.html;400.49737579337926;419.86774166137667;429.6541284266166;435.96948213625046;441.22564898602946;16487.917560412196;20492;21168.153273869048;22286.77713222871;22615.321540353776;21147.365579032616;21548.784512154874;21590.89204553975;21670.133194672235;21717.3484795456;5691.743871525791;5816.970915145429;5918.201042859224;6040.275166979968;6043.576949613507;5864.472197502224;5866.911996320037;5887.35239123696;5893.263342082239;5901.114832775075;5724.227229324029;5870.559708021894;5875.383084776101;5888.5289176865745;5924.911126333109;5907.970460147693;5937.52499800015;5951.285845698522;5951.821445356603;5955.047192449209;5135;5281.471852814726;5339.252504649352;5347.572194224453;5353.785848566053;24754;24806.25581232548;24940;25274.747252527424;25294.114705985387;2527.898884044636;2727.6726792784993;2812.943741125166;3248.187953011747;3329.983350083234;14358.784618230735;14426.350814213385;14664.706705865823;15342.539723808304;15592.532224033297;1956.4521933858543;2011.4367976966473;2013.4865609269543;2047.9590408191902;2100.579884023186;88551.09349085277;89761.55119224363;90730;91946;92229;10061.144802691706;10662.626808061681;10848.67453976382;10959.726006849733;11166.720831979266;13953.930230348784;14539.27303634814;14605.269736513344;14641.48754793577;14659;9112.225460835904;9247.861282080774;9249.398789078688;9348.906510934803;9455.007224241494;9223;9248.583813728399;9274.026227246177;9289.535523223813;9489.430634161972;6909.136357955255;6996.19543752475;7018.1929078155645;7114.217436082027;7144.607046612487;2000.0899590686204;2005.7994200579826;2040.908159132813;2047.4778931372703;2088.4361222469847;1087.0814162033068;1099.9010089092021;1140.9828852567218;1142.3774043146504;1154.7286387698884;21033.263835765676;21143.154273829183;21542.569148617255;21620.891895540422;21633.242836500645;1038.4340534408614;1062.3466568060587;1067.5196161727254;1075.1237741240864;1078.5524007536942;11378.544858205745;11912.40437978115;12225.877741222652;12281.140320177501;12324.50701971929;455468;459825;464614;509447;515920;87649.56175219083;88744;89303;89831.10168898357;90684;1021.9540120694735;1123.7640095579857;1150.206357613244;1154.4054811771944;1162.3839365136491;18355.724664129782;18561.16474758666;18960.51929131342;19068.33260835864;19102.808971910657;29953.85023074958;43245;44640.55359446494;44651.77674111609;44977.77511112423;57624.423755761905;59358;60056;66282.66858665869;67904.3209567898;9055.139761722627;9105.226055785333;9225.308101892519;9239.353245272767;9514.952425237829;13353.66615834573;13363.799543006668;13567.118137321042;13597.79603305971;13705.177689338672;12005.699857503632;12019.939900300442;12028.15802893824;12286.447109879899;12541.31022793755;11921.940390297994;12055.21641093326;12129.575464858688;12290;12516.186447880858;12193.756124877274;12363.443645036175;12470.563530276397;12500.374981251083;12911;9032.36773425854;9137.497437640994;9294.070592940921;9425.340226184102;9733.805323893625;9685.612575496902;12288.324142171909;12403.813942791046;12637.684057898627;12798.552050678181 03:46:43 INFO - PROCESS | 7282 | |3;mootools.html;1531.058399084563;1535.1786794065174;1669.3322670931625;1780.928762849486;1786.562292238401;7599.27806858349;7849.372050235982;8514.616842242098;9186.816263674722;9199.678011269598;8406.83186336273;8732.781680457992;8733.34499912506;8987.685431009915;8992.505412202327;2429.149797570854;2445.217530390276;2449.081594402099;2464.8028157747335;2472.4560596668703;2042.77529471758;2117.4494631395796;2279.954400911989;2376.394019525019;2413.613821788514;2417.9516409671796;2443.6456713776493;2446.877656117196;2463.0394146282965;2467.938301542458;2395.1257790906366;2405.591049521568;2418.8548687078655;2418.8669623170717;2425.9393515162087;2374.3114496795906;2375.7743014413604;2382.487765130488;2386.5107652931106;2397.8561286322874;8772.254358379545;8893.377463577552;8927.196552310259;8928.910710892873;9005.50469724165;5217.5565076968505;5342.626016178869;5348.224507446437;5351.545118664918;5362.276092727471;3278.5760156085494;3374.105861946586;3376.9831150844334;3388.610309814378;3392.745544084179;1116.35809409589;1156.2773266708307;1166.8249762535602;1168.4333098447246;1181.102362204722;12021.338826364547;12038.939805300917;12045.096617753616;12063.577774777841;12067.758644827141;4652.464966528825;4687.601553867959;4741.1465936131135;4800.495947925418;4817.0606731687685;10222;10245.334053286513;10250.897491025144;10261.076503114755;10264.948675256575;5389.973050134724;5397.217403476474;5399.730013499309;5401.810936617199;5421;4875.34182885313;4958.652894297365;4962.5533701967;4964.404271487445;5028.949710502921;3782.6973842092566;3931.8427262909736;3946.151577410813;3986.5614782373914;4140.213359461693;1363.0644484831564;1378.0560316183446;1378.8690074443111;1395.6231817409446;1405.8875289976777;852.4373913217247;903;937.6436953957589;991.6975322526555;994.8209322321907;5802.564807639444;5889.882202355929;5967.582269241198;6006.429389208019;6162.691865406712;1005.5173516711873;1019.2559431614815;1020.1277907389075;1030.7680771826278;1048.3343077145914;4010.63904248619;4040.7171497995446;4159.376093585925;4177.791110444466;4202.180574787887;10685.519151638195;11132.944335278435;11142.164337674707;11163.106951443864;11167.106631469625;10972.506237219344;10989.725256868482;11015.118790496901;11019.173561982883;11075.778484430266;7734.071911370784;8334.458260213067;8391.580420978926;8397.958010210032;8414.36892233085;5933.732982015733;5941.910871336847;6012.338642749207;6045.879082418415;6078.331383547895;9845.064718851698;9992.800143997225;10091.394516329045;10142.746431339276;10145;10261.692149235534;10335.431551264752;10346.689599312032;10398.376097434179;10452.268341216042;7822.804429889298;7834;7881.487703299267;7885.881711774213;7931.246531579491;7348.595827229554;7646.65590048438;8108.351331893552;8153;8162.061362943337;6848.3494068063455;7295.306945840137;7542.509736867086;7578.848423031398;7586.165521792488;7278.963605182152;7361.742339018108;7368.336849683555;7418.925810741824;7421.777346679608;6703.262641109376;6798.52410331272;6808.863822723617;6813.386795188457;6816.7614133505085;5125.205593133071;5209.71346575942;5213;5257.89484210306;5454.863628409322;4905.288733133604;5061.013102444987;5070.442251352422;5075.213341932006;5250.737463126905 03:46:43 INFO - PROCESS | 7282 | |4;prototype.html;329.72725280417586;336.9663033696629;338.98305084745755;340.86024729860753;349.53162761899057;5533.750981205845;5618.77524899004;5630.7184640768;5641.915371269434;5646.0076159635355;5187.870303242421;5331.813386531472;5355.223492593572;5457.754401051952;5460.31746031746;4333.198358303708;4347;4349.369341445488;4352.608265256126;4360.78196090195;4233.689421189105;4338.652907767371;4339.544347843478;4345.760983145926;4362.171187474386;4315.43899293093;4319.784010799447;4323.762193079379;4324.870253892373;4329.372241025065;4271.743695378256;4277.508086570053;4290.120525292307;4313.352997050451;4314.697971142005;3826.215625796705;3839.8464061437508;3848.9230215395814;3863.1026729952537;3865.61343865614;5302.787888484456;5395.865103372408;5431.701256430894;5436.891262174774;5455.236266922634;4964.329815474901;4997.275395067732;5006.798368391596;5008.424031236382;5013.821751888303;5732.8853422931725;5765.711714414305;5772.538196944234;5774.624649397818;5788.0739081746715;4026.879193624196;4177.10192308652;4186.853460128911;4230.773075808012;4232.76719780412;5987.221661184061;5995.1906492623375;6000.849978750566;6002.129691194796;6005.909911351333;4355.760433176142;4358.3244597087505;4359.215341238608;4361.214981303332;4368.126374725068;4233.470816147981;4319.611234988866;4384.934225986613;4386.539413361615;4389.122175564899;4931.827386041543;4936;4946;4954.380702412199;4982.800687972441;5786.479216870502;5788.842231553706;5802.187693722883;5814.709264536757;5829.484334073171;1378.9241591712553;1411.2167746900568;1436.8275806903239;1441.654003039284;1443.4009885897235;952.7427594549572;968.6077138758814;989.9010098990187;1012.4431562640518;1018.6452018814958;5520.006398848165;5528.668279903219;5540.2243685884005;5583.720813959286;5594.328680558359;5773;5842.009667205946;5844.9415505845245;5921.697226610139;5936.643801371932;5547;5550.833474995757;5557.194206839986;5564.19319198722;5567;3111.0355789705263;3124.734397576186;3132.827694476826;3133.7806353555034;3140.7173354398215;5736.6844823534275;5878.764849406061;5975.790847320323;5975.83471223116;6005.429484198994;5936.643801371932;5939.940600593939;5976.671283079472;5986.73059712314;6001.5198784097165;5852.824415267463;5934.97032514852;6021.42796434338;6034.818955431344;6053.909191362133;5882.205902203148;5888.234529511136;5891.675957822361;5897.7935772247765;5912.615679980788;5830.726016853515;5832.883342333044;5834.15404766315;5837.095250236051;5839.532837372915;5866.2373891393845;6169.259688837368;6222.688865556614;6226.533010024357;6231.813045608639;4298.849540266076;4306.698531102918;4313.619641714621;4315.503717072451;4326.740395576276;5738.569607279387;5964.194833697569;6041.365656605993;6063.211782468427;6068.150458935665;5848.239728835224;5874.706264686834;5879.470847623564;5879.823605291848;5883.852903677443;5819.476247137778;5827.912581311199;5845.444682755132;5850.6997356941765;5851.327097383685;5173.40505841833;5388.838334849961;5791.262621213703;5816.854578635399;5822.82531524055;5840.2991641003355;5849.766009359748;5856.326522449973;5866.911996319973;5884.352721200579;5521.972390138184;5638.5489160867855;5705.831783922083;5713.285839270091;5737.827865164052 03:46:43 INFO - PROCESS | 7282 | |5;yui.html;798.9121196668366;807.4025221336213;819.5287709566996;827.3463963468859;947.4078700811992;15622.375104995801;18214.726779098306;18320.35878744244;18341.7248741269;18384.632307353862;15371.00088494247;15430.382784688627;15485.535433936971;15490.61273468164;15530.534083977498;863.7667829685981;895.9462432254053;898.0794685447436;898.2634239923266;898.8337157625828;891.7859713668705;894.5840184314293;896.278495810872;896.560685264219;897.2821742605889;929.6606738540418;932.9346945713803;933.0995589256366;933.2627224492643;935.6912218967758;929.4609126706493;930.060638754859;930.1070971867016;930.2790337488467;930.418488444722;684.5003147702205;689.7723751162155;689.8482333886537;690.689189864563;690.9689063992132;14957;15050.548483545512;15177.544673659808;15217.086974781549;15217.467388641344;14404.92797536016;14563.635909102251;14679.706405871822;14900.254987250593;14922;11918;11985.58050468238;12404.875951240463;12456.190347627375;12839.229646221256;4021.77880216588;4082.5917408259234;4101.958980410217;4169.957510622345;4232.78836058199;82103.5894820528;83240.58379708063;84807;85448.57275713644;86609.56695216546;12162.270263784025;12170.939145304217;12182.269063856196;12217.633470995885;12481.875181248253;22197.445063873532;22308.10767569279;22339.66490502644;22358.552828943655;22370.32889013332;8815.206631403205;8863.157999989991;8941.46351218929;8975.326850486239;9242.353035287466;4652.464966528825;4897.578958843328;4970.453250142481;5018.949810501921;5028.899422011539;3540.716742660581;3666.211764470652;3670.284294562535;3670.724695647837;3679.9080022999638;632.1560716443599;632.2381530256031;643.2731013954295;645.0646562484417;646.2793984707018;661.2395744893411;701.0640794539347;731.7914394397571;747.271410374891;753.1677496366436;10233.692989210336;10282.691519254435;10505.9474702626;10979.725506862393;10995.395253261147;706.5195666946526;720.9366184877368;759.9012128423269;775.6393277126051;794.3724457678369;5110.642255042186;5125.103106956342;5128.307678463434;5132.332796736475;5187.351581052369;133108;134548.32725836308;134881.32559337336;135129;137093.3145334267;66539;78851.60574197093;94184;114965.4251728736;120067.39966300287;94822;95525.9999999986;97982;100168.49915750374;100387.49806250921;9700.75748106303;9993.200543956611;10005.849912251177;10036.347637403545;10140.898591013995;49958.25062624136;52328;53517.46482535125;53995.46004539904;54828.72585637046;74950;81207;83022;83997.580012102;86581.56709216414;13501.324933753469;13756.587302380945;13884.166949983033;13983.510577129751;14590.781138282722;16352.427665032143;16366.263518141473;17380.91309543495;17745.378911738026;17769.289228431237;13891.583252502442;14454.927725361305;14667;14776.778348324999;15174.468893589114;14854.851451485347;14900.925495372454;15034.097954122788;15098.773518397453;15113.54659360221;14804.481843135438;14911.17988510599;14947.85052149508;14998.175100369584;15082.321295541946;11413.885861141614;11794.941025295162;11807.291562506278;11859.110566707704;12013.244507891175;12055.15613907018;12195.939020304842;12275.140740148461;12385.009199264217;12553 03:46:43 INFO - PROCESS | 7282 | __end_tp_report 03:46:43 INFO - PROCESS | 7282 | __start_cc_report 03:46:43 INFO - PROCESS | 7282 | _x_x_mozilla_cycle_collect,900 03:46:43 INFO - PROCESS | 7282 | __end_cc_report 03:46:43 INFO - PROCESS | 7282 | __startTimestamp1477651603598__endTimestamp 03:46:43 INFO - PROCESS | 7282 | 03:46:43 INFO - PROCESS | 7282 | ------- Summary: start ------- 03:46:43 INFO - PROCESS | 7282 | Number of tests: 6 03:46:43 INFO - PROCESS | 7282 | 03:46:43 INFO - PROCESS | 7282 | [#0] dojo.html Cycles:165 Average:5524.29 Median:5745.68 stddev:624.29 (10.9%) stddev-sans-first:597.41 03:46:43 INFO - PROCESS | 7282 | Values: 3135.4 3171.0 3182.1 3204.9 3223.5 5490.3 5546.2 5559.8 5577.3 5578.9 5557.1 5607.5 5621.8 5628.3 5644.2 5048.2 5063.3 5099.9 5136.0 5143.7 4939.0 5116.4 5163.8 5176.1 5178.7 4895.2 4971.8 5004.5 5008.5 5042.4 5072.9 5101.1 5103.3 5165.1 5200.1 4862.4 5040.9 5069.4 5120.3 5132.2 5425.2 5454.6 5455.7 5461.9 5537.4 5900.7 5911.4 5958.5 5964.6 5998.3 5791.6 6021.6 6022.5 6023.8 6027.3 5442.2 5516.8 5577.9 5581.7 5605.1 6127.0 6152.9 6155.7 6156.5 6163.4 5745.7 5921.5 5921.7 5925.1 5925.3 5823.8 5861.6 5862.9 5881.0 5965.9 5846.5 5848.3 5906.2 5907.4 5937.9 5801.8 5849.6 5879.7 5916.2 5917.8 4472.7 4503.2 4540.5 4578.2 4597.6 4087.2 4098.5 4099.2 4101.3 4114.9 5647.3 5658.6 5658.9 5663.3 5666.5 5744.9 5784.5 5893.0 5931.3 5985.6 5649.1 5668.0 5692.5 5694.0 5729.6 5191.4 5199.0 5201.5 5203.8 5237.8 5867.4 5896.3 6104.7 6193.5 6203.9 5970.9 6021.2 6027.4 6058.6 6068.3 6193.5 6215.3 6221.3 6225.2 6226.5 5689.7 5702.4 5899.2 5939.3 5939.9 5813.5 5871.6 5878.6 5942.8 5975.6 5791.8 5794.6 5795.8 5799.8 5802.2 5585.7 5787.1 5788.3 5791.0 5792.1 5547.1 5751.1 5768.7 5804.7 5889.8 5804.7 5895.9 5899.4 5906.4 5908.9 5595.8 5640.7 5745.8 5751.3 5764.3 03:46:43 INFO - PROCESS | 7282 | 03:46:43 INFO - PROCESS | 7282 | [#1] ext.html Cycles:180 Average:55117.72 Median:39305.01 stddev:104311.70 (265.4%) stddev-sans-first:104523.96 03:46:43 INFO - PROCESS | 7282 | Values: 582.1 597.3 614.8 627.7 643.0 34995.7 45926.3 46616.8 46701.0 50984.0 48878.0 49232.3 49297.5 49396.5 49396.8 8449.7 9368.9 9505.5 9526.8 9531.4 8440.8 10981.7 11275.5 11282.4 11655.1 11333.0 11333.1 11335.5 11345.1 11386.7 11024.1 11216.1 11217.4 11220.7 11247.6 11132.1 11198.4 11199.6 11205.7 11207.2 46370.1 46583.0 46767.5 46767.5 46779.3 3800.3 3811.0 3863.5 4124.1 4437.3 34636.3 35252.5 35285.6 36676.4 36989.6 4153.4 4173.1 4349.3 4391.9 4412.6 378192.0 378692.0 385014.1 385127.0 385426.0 39380.6 64251.0 64655.7 64680.7 64707.0 39752.6 41675.8 41721.0 41726.0 41757.8 17462.7 17697.3 17701.7 17721.1 17730.1 13604.7 13950.4 13959.4 14072.3 14522.3 9368.5 9701.8 9726.7 9731.1 9799.1 3682.7 3686.9 3691.2 3702.0 3735.9 1064.7 1093.1 1113.4 1115.8 1236.8 33984.2 33991.0 34280.8 34551.5 34655.3 1155.7 1221.1 1225.7 1309.2 1321.4 17996.3 18053.8 18150.8 18363.2 18458.0 155460.0 155911.2 157129.0 157549.2 157655.0 63521.7 64079.7 64115.7 64122.4 64283.4 1331.3 1362.6 1423.0 1444.8 1472.8 30430.8 34266.5 35502.6 35531.3 35854.1 61575.1 62594.4 62654.7 62923.7 62974.0 534575.0 536652.0 537922.0 539605.0 540080.0 46698.0 47542.3 48264.5 48559.5 48560.8 52004.7 52184.5 52630.7 52699.7 52863.2 44062.8 44070.8 44537.0 45555.3 46313.0 44745.3 45078.3 45927.5 46128.3 46575.5 44326.6 44873.6 45685.5 45814.5 45841.5 35887.5 38872.8 39229.4 39422.8 39776.2 29318.5 29759.4 29814.3 30228.1 30251.2 03:46:43 INFO - PROCESS | 7282 | 03:46:43 INFO - PROCESS | 7282 | [#2] jquery.html Cycles:180 Average:29729.73 Median:24873.13 stddev:79539.30 (319.8%) stddev-sans-first:79731.94 03:46:43 INFO - PROCESS | 7282 | Values: 400.5 419.9 429.7 436.0 441.2 16487.9 20492.0 21168.2 22286.8 22615.3 21147.4 21548.8 21590.9 21670.1 21717.3 5691.7 5817.0 5918.2 6040.3 6043.6 5864.5 5866.9 5887.4 5893.3 5901.1 5724.2 5870.6 5875.4 5888.5 5924.9 5908.0 5937.5 5951.3 5951.8 5955.0 5135.0 5281.5 5339.3 5347.6 5353.8 24754.0 24806.3 24940.0 25274.7 25294.1 2527.9 2727.7 2812.9 3248.2 3330.0 14358.8 14426.4 14664.7 15342.5 15592.5 1956.5 2011.4 2013.5 2048.0 2100.6 88551.1 89761.6 90730.0 91946.0 92229.0 10061.1 10662.6 10848.7 10959.7 11166.7 13953.9 14539.3 14605.3 14641.5 14659.0 9112.2 9247.9 9249.4 9348.9 9455.0 9223.0 9248.6 9274.0 9289.5 9489.4 6909.1 6996.2 7018.2 7114.2 7144.6 2000.1 2005.8 2040.9 2047.5 2088.4 1087.1 1099.9 1141.0 1142.4 1154.7 21033.3 21143.2 21542.6 21620.9 21633.2 1038.4 1062.3 1067.5 1075.1 1078.6 11378.5 11912.4 12225.9 12281.1 12324.5 455468.0 459825.0 464614.0 509447.0 515920.0 87649.6 88744.0 89303.0 89831.1 90684.0 1022.0 1123.8 1150.2 1154.4 1162.4 18355.7 18561.2 18960.5 19068.3 19102.8 29953.9 43245.0 44640.6 44651.8 44977.8 57624.4 59358.0 60056.0 66282.7 67904.3 9055.1 9105.2 9225.3 9239.4 9515.0 13353.7 13363.8 13567.1 13597.8 13705.2 12005.7 12019.9 12028.2 12286.4 12541.3 11921.9 12055.2 12129.6 12290.0 12516.2 12193.8 12363.4 12470.6 12500.4 12911.0 9032.4 9137.5 9294.1 9425.3 9733.8 9685.6 12288.3 12403.8 12637.7 12798.6 03:46:43 INFO - PROCESS | 7282 | 03:46:43 INFO - PROCESS | 7282 | [#3] mootools.html Cycles:180 Average:5797.65 Median:4770.82 stddev:3248.01 (68.1%) stddev-sans-first:3241.30 03:46:43 INFO - PROCESS | 7282 | Values: 1531.1 1535.2 1669.3 1780.9 1786.6 7599.3 7849.4 8514.6 9186.8 9199.7 8406.8 8732.8 8733.3 8987.7 8992.5 2429.1 2445.2 2449.1 2464.8 2472.5 2042.8 2117.4 2280.0 2376.4 2413.6 2418.0 2443.6 2446.9 2463.0 2467.9 2395.1 2405.6 2418.9 2418.9 2425.9 2374.3 2375.8 2382.5 2386.5 2397.9 8772.3 8893.4 8927.2 8928.9 9005.5 5217.6 5342.6 5348.2 5351.5 5362.3 3278.6 3374.1 3377.0 3388.6 3392.7 1116.4 1156.3 1166.8 1168.4 1181.1 12021.3 12038.9 12045.1 12063.6 12067.8 4652.5 4687.6 4741.1 4800.5 4817.1 10222.0 10245.3 10250.9 10261.1 10264.9 5390.0 5397.2 5399.7 5401.8 5421.0 4875.3 4958.7 4962.6 4964.4 5028.9 3782.7 3931.8 3946.2 3986.6 4140.2 1363.1 1378.1 1378.9 1395.6 1405.9 852.4 903.0 937.6 991.7 994.8 5802.6 5889.9 5967.6 6006.4 6162.7 1005.5 1019.3 1020.1 1030.8 1048.3 4010.6 4040.7 4159.4 4177.8 4202.2 10685.5 11132.9 11142.2 11163.1 11167.1 10972.5 10989.7 11015.1 11019.2 11075.8 7734.1 8334.5 8391.6 8398.0 8414.4 5933.7 5941.9 6012.3 6045.9 6078.3 9845.1 9992.8 10091.4 10142.7 10145.0 10261.7 10335.4 10346.7 10398.4 10452.3 7822.8 7834.0 7881.5 7885.9 7931.2 7348.6 7646.7 8108.4 8153.0 8162.1 6848.3 7295.3 7542.5 7578.8 7586.2 7279.0 7361.7 7368.3 7418.9 7421.8 6703.3 6798.5 6808.9 6813.4 6816.8 5125.2 5209.7 5213.0 5257.9 5454.9 4905.3 5061.0 5070.4 5075.2 5250.7 03:46:43 INFO - PROCESS | 7282 | 03:46:43 INFO - PROCESS | 7282 | [#4] prototype.html Cycles:180 Average:4878.22 Median:5554.01 stddev:1424.75 (25.7%) stddev-sans-first:1387.24 03:46:43 INFO - PROCESS | 7282 | Values: 329.7 337.0 339.0 340.9 349.5 5533.8 5618.8 5630.7 5641.9 5646.0 5187.9 5331.8 5355.2 5457.8 5460.3 4333.2 4347.0 4349.4 4352.6 4360.8 4233.7 4338.7 4339.5 4345.8 4362.2 4315.4 4319.8 4323.8 4324.9 4329.4 4271.7 4277.5 4290.1 4313.4 4314.7 3826.2 3839.8 3848.9 3863.1 3865.6 5302.8 5395.9 5431.7 5436.9 5455.2 4964.3 4997.3 5006.8 5008.4 5013.8 5732.9 5765.7 5772.5 5774.6 5788.1 4026.9 4177.1 4186.9 4230.8 4232.8 5987.2 5995.2 6000.8 6002.1 6005.9 4355.8 4358.3 4359.2 4361.2 4368.1 4233.5 4319.6 4384.9 4386.5 4389.1 4931.8 4936.0 4946.0 4954.4 4982.8 5786.5 5788.8 5802.2 5814.7 5829.5 1378.9 1411.2 1436.8 1441.7 1443.4 952.7 968.6 989.9 1012.4 1018.6 5520.0 5528.7 5540.2 5583.7 5594.3 5773.0 5842.0 5844.9 5921.7 5936.6 5547.0 5550.8 5557.2 5564.2 5567.0 3111.0 3124.7 3132.8 3133.8 3140.7 5736.7 5878.8 5975.8 5975.8 6005.4 5936.6 5939.9 5976.7 5986.7 6001.5 5852.8 5935.0 6021.4 6034.8 6053.9 5882.2 5888.2 5891.7 5897.8 5912.6 5830.7 5832.9 5834.2 5837.1 5839.5 5866.2 6169.3 6222.7 6226.5 6231.8 4298.8 4306.7 4313.6 4315.5 4326.7 5738.6 5964.2 6041.4 6063.2 6068.2 5848.2 5874.7 5879.5 5879.8 5883.9 5819.5 5827.9 5845.4 5850.7 5851.3 5173.4 5388.8 5791.3 5816.9 5822.8 5840.3 5849.8 5856.3 5866.9 5884.4 5522.0 5638.5 5705.8 5713.3 5737.8 03:46:43 INFO - PROCESS | 7282 | 03:46:43 INFO - PROCESS | 7282 | [#5] yui.html Cycles:180 Average:22534.24 Median:3675.32 stddev:33097.35 (900.5%) stddev-sans-first:33149.96 03:46:43 INFO - PROCESS | 7282 | Values: 798.9 807.4 819.5 827.3 947.4 15622.4 18214.7 18320.4 18341.7 18384.6 15371.0 15430.4 15485.5 15490.6 15530.5 863.8 895.9 898.1 898.3 898.8 891.8 894.6 896.3 896.6 897.3 929.7 932.9 933.1 933.3 935.7 929.5 930.1 930.1 930.3 930.4 684.5 689.8 689.8 690.7 691.0 14957.0 15050.5 15177.5 15217.1 15217.5 14404.9 14563.6 14679.7 14900.3 14922.0 11918.0 11985.6 12404.9 12456.2 12839.2 4021.8 4082.6 4102.0 4170.0 4232.8 82103.6 83240.6 84807.0 85448.6 86609.6 12162.3 12170.9 12182.3 12217.6 12481.9 22197.4 22308.1 22339.7 22358.6 22370.3 8815.2 8863.2 8941.5 8975.3 9242.4 4652.5 4897.6 4970.5 5018.9 5028.9 3540.7 3666.2 3670.3 3670.7 3679.9 632.2 632.2 643.3 645.1 646.3 661.2 701.1 731.8 747.3 753.2 10233.7 10282.7 10505.9 10979.7 10995.4 706.5 720.9 759.9 775.6 794.4 5110.6 5125.1 5128.3 5132.3 5187.4 133108.0 134548.3 134881.3 135129.0 137093.3 66539.0 78851.6 94184.0 114965.4 120067.4 94822.0 95526.0 97982.0 100168.5 100387.5 9700.8 9993.2 10005.8 10036.3 10140.9 49958.3 52328.0 53517.5 53995.5 54828.7 74950.0 81207.0 83022.0 83997.6 86581.6 13501.3 13756.6 13884.2 13983.5 14590.8 16352.4 16366.3 17380.9 17745.4 17769.3 13891.6 14454.9 14667.0 14776.8 15174.5 14854.9 14900.9 15034.1 15098.8 15113.5 14804.5 14911.2 14947.9 14998.2 15082.3 11413.9 11794.9 11807.3 11859.1 12013.2 12055.2 12195.9 12275.1 12385.0 12553.0 03:46:43 INFO - PROCESS | 7282 | -------- Summary: end -------- 03:46:43 INFO - PROCESS | 7282 | 03:46:44 INFO - TEST-INFO | 7282: exit 0 03:46:44 INFO - TEST-OK | dromaeo_css | took 1113805ms 03:46:44 INFO - TEST-START | kraken 03:46:44 INFO - operating with platform_type : linux_ 03:46:44 INFO - Initialising browser for kraken test... 03:46:44 INFO - TEST-INFO | started process 7601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppf9EcW/profile http://localhost:49140/getInfo.html) 03:46:48 INFO - PROCESS | 7601 | __metrics Screen width/height:1600/1200 03:46:48 INFO - PROCESS | 7601 | colorDepth:24 03:46:48 INFO - PROCESS | 7601 | Browser inner width/height: 1024/697 03:46:48 INFO - PROCESS | 7601 | __metrics 03:46:48 INFO - PROCESS | 7601 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:46:48 INFO - PROCESS | 7601 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:46:49 INFO - PROCESS | 7601 | console.error: PushService: 03:46:49 INFO - PROCESS | 7601 | stateChangeProcessEnqueue: Error transitioning state 03:46:49 INFO - PROCESS | 7601 | UnknownError 03:46:49 INFO - TEST-INFO | 7601: exit 0 03:46:49 INFO - Browser initialized. 03:46:49 INFO - Running cycle 1/1 for kraken test... 03:46:49 INFO - TEST-INFO | started process 7691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppf9EcW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:01 INFO - PROCESS | 7691 | RSS: Main: 144322560 03:47:01 INFO - PROCESS | 7691 | 03:47:04 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49140/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:05 INFO - PROCESS | 7691 | RSS: Main: 186679296 03:47:05 INFO - PROCESS | 7691 | 03:47:07 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49140/tests/kraken/driver.html?testName=audio-dft) 03:47:08 INFO - PROCESS | 7691 | RSS: Main: 176091136 03:47:08 INFO - PROCESS | 7691 | 03:47:11 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49140/tests/kraken/driver.html?testName=audio-fft) 03:47:11 INFO - PROCESS | 7691 | RSS: Main: 267513856 03:47:11 INFO - PROCESS | 7691 | 03:47:13 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49140/tests/kraken/driver.html?testName=audio-oscillator) 03:47:14 INFO - PROCESS | 7691 | RSS: Main: 173633536 03:47:14 INFO - PROCESS | 7691 | 03:47:16 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49140/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:17 INFO - PROCESS | 7691 | RSS: Main: 174727168 03:47:17 INFO - PROCESS | 7691 | 03:47:19 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49140/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:20 INFO - PROCESS | 7691 | RSS: Main: 210796544 03:47:20 INFO - PROCESS | 7691 | 03:47:23 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49140/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:24 INFO - PROCESS | 7691 | RSS: Main: 209977344 03:47:24 INFO - PROCESS | 7691 | 03:47:27 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49140/tests/kraken/driver.html?testName=json-parse-financial) 03:47:27 INFO - PROCESS | 7691 | RSS: Main: 209498112 03:47:27 INFO - PROCESS | 7691 | 03:47:29 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49140/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:29 INFO - PROCESS | 7691 | RSS: Main: 172060672 03:47:29 INFO - PROCESS | 7691 | 03:47:31 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49140/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:32 INFO - PROCESS | 7691 | RSS: Main: 179171328 03:47:32 INFO - PROCESS | 7691 | 03:47:34 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49140/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:34 INFO - PROCESS | 7691 | RSS: Main: 188674048 03:47:34 INFO - PROCESS | 7691 | 03:47:37 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:38 INFO - PROCESS | 7691 | RSS: Main: 197095424 03:47:38 INFO - PROCESS | 7691 | 03:47:40 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:41 INFO - PROCESS | 7691 | RSS: Main: 193658880 03:47:41 INFO - PROCESS | 7691 | 03:47:42 INFO - PROCESS | 7691 | Cycle 1(1): loaded http://localhost:49140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49140/tests/kraken/driver.html?testName=ai-astar) 03:47:43 INFO - PROCESS | 7691 | RSS: Main: 244387840 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | __start_tp_report 03:47:43 INFO - PROCESS | 7691 | _x_x_mozilla_page_load 03:47:43 INFO - PROCESS | 7691 | _x_x_mozilla_page_load_details 03:47:43 INFO - PROCESS | 7691 | |i|pagename|runs| 03:47:43 INFO - PROCESS | 7691 | |0;ai-astar;111;112;113;111;111;111;111;111;110;111 03:47:43 INFO - PROCESS | 7691 | |1;audio-beat-detection;143;119;118;149;118;120;116;118;159;122 03:47:43 INFO - PROCESS | 7691 | |2;audio-dft;160;160;161;160;161;160;159;160;162;159 03:47:43 INFO - PROCESS | 7691 | |3;audio-fft;75;75;75;110;76;75;75;77;117;75 03:47:43 INFO - PROCESS | 7691 | |4;audio-oscillator;82;82;111;82;83;83;111;83;82;112 03:47:43 INFO - PROCESS | 7691 | |5;imaging-gaussian-blur;118;118;118;118;119;118;117;117;117;117 03:47:43 INFO - PROCESS | 7691 | |6;imaging-darkroom;145;146;146;146;146;146;147;147;145;147 03:47:43 INFO - PROCESS | 7691 | |7;imaging-desaturate;95;95;97;96;96;96;95;95;96;95 03:47:43 INFO - PROCESS | 7691 | |8;json-parse-financial;49;49;54;49;49;49;50;49;48;50 03:47:43 INFO - PROCESS | 7691 | |9;json-stringify-tinderbox;59;61;59;60;59;59;59;60;64;59 03:47:43 INFO - PROCESS | 7691 | |10;stanford-crypto-aes;74;81;76;75;73;72;74;81;73;73 03:47:43 INFO - PROCESS | 7691 | |11;stanford-crypto-ccm;134;127;121;127;122;131;117;128;151;135 03:47:43 INFO - PROCESS | 7691 | |12;stanford-crypto-pbkdf2;160;157;153;152;155;156;156;151;160;153 03:47:43 INFO - PROCESS | 7691 | |13;stanford-crypto-sha256-iterative;64;61;61;62;62;64;62;66;61;61 03:47:43 INFO - PROCESS | 7691 | __end_tp_report 03:47:43 INFO - PROCESS | 7691 | __start_cc_report 03:47:43 INFO - PROCESS | 7691 | _x_x_mozilla_cycle_collect,1626 03:47:43 INFO - PROCESS | 7691 | __end_cc_report 03:47:43 INFO - PROCESS | 7691 | __startTimestamp1477651663209__endTimestamp 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | ------- Summary: start ------- 03:47:43 INFO - PROCESS | 7691 | Number of tests: 14 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 03:47:43 INFO - PROCESS | 7691 | Values: 111.0 112.0 113.0 111.0 111.0 111.0 111.0 111.0 110.0 111.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:121.00 stddev:15.82 (13.1%) stddev-sans-first:15.84 03:47:43 INFO - PROCESS | 7691 | Values: 143.0 119.0 118.0 149.0 118.0 120.0 116.0 118.0 159.0 122.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 03:47:43 INFO - PROCESS | 7691 | Values: 160.0 160.0 161.0 160.0 161.0 160.0 159.0 160.0 162.0 159.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:16.17 (21.6%) stddev-sans-first:16.89 03:47:43 INFO - PROCESS | 7691 | Values: 75.0 75.0 75.0 110.0 76.0 75.0 75.0 77.0 117.0 75.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:13.97 (17.0%) stddev-sans-first:14.43 03:47:43 INFO - PROCESS | 7691 | Values: 82.0 82.0 111.0 82.0 83.0 83.0 111.0 83.0 82.0 112.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:47:43 INFO - PROCESS | 7691 | Values: 118.0 118.0 118.0 118.0 119.0 118.0 117.0 117.0 117.0 117.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 03:47:43 INFO - PROCESS | 7691 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 145.0 147.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 03:47:43 INFO - PROCESS | 7691 | Values: 95.0 95.0 97.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:49.00 stddev:1.65 (3.4%) stddev-sans-first:1.73 03:47:43 INFO - PROCESS | 7691 | Values: 49.0 49.0 54.0 49.0 49.0 49.0 50.0 49.0 48.0 50.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:59.50 stddev:1.60 (2.7%) stddev-sans-first:1.66 03:47:43 INFO - PROCESS | 7691 | Values: 59.0 61.0 59.0 60.0 59.0 59.0 59.0 60.0 64.0 59.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:74.50 stddev:3.26 (4.4%) stddev-sans-first:3.43 03:47:43 INFO - PROCESS | 7691 | Values: 74.0 81.0 76.0 75.0 73.0 72.0 74.0 81.0 73.0 73.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:129.50 stddev:9.51 (7.3%) stddev-sans-first:9.93 03:47:43 INFO - PROCESS | 7691 | Values: 134.0 127.0 121.0 127.0 122.0 131.0 117.0 128.0 151.0 135.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:156.00 stddev:3.13 (2.0%) stddev-sans-first:2.82 03:47:43 INFO - PROCESS | 7691 | Values: 160.0 157.0 153.0 152.0 155.0 156.0 156.0 151.0 160.0 153.0 03:47:43 INFO - PROCESS | 7691 | 03:47:43 INFO - PROCESS | 7691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.71 (2.8%) stddev-sans-first:1.72 03:47:43 INFO - PROCESS | 7691 | Values: 64.0 61.0 61.0 62.0 62.0 64.0 62.0 66.0 61.0 61.0 03:47:43 INFO - PROCESS | 7691 | -------- Summary: end -------- 03:47:43 INFO - PROCESS | 7691 | 03:47:44 INFO - TEST-INFO | 7691: exit 0 03:47:44 INFO - TEST-OK | kraken | took 59850ms 03:47:44 INFO - SUITE-END | took 1173s 03:47:44 INFO - Completed test suite (00:19:33) 03:47:44 INFO - javascript benchmark 03:47:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.4199473097474, 3171.0328349853285, 3182.124915648198, 3204.887828925988, 3223.4681277589198, 5490.341159060913, 5546.223528705985, 5559.805406810762, 5577.330720313568, 5578.944210557893, 5557.055300598898, 5607.523360514361, 5621.80323688671, 5628.26832511774, 5644.181593668915, 5048.217526283432, 5063.291139240509, 5099.949000509984, 5136.049830781299, 5143.691378517282, 4939.0, 5116.437191908887, 5163.793448262084, 5176.0683077046115, 5178.741062946838, 4895.167821470341, 4971.825986090469, 5004.474530174334, 5008.524190201925, 5042.4201216860165, 5072.949270507284, 5101.056304583645, 5103.311053007834, 5165.147750621143, 5200.115980283361, 4862.3922009748785, 5040.873978150539, 5069.391672999263, 5120.334356533627, 5132.204508301182, 5425.213344065128, 5454.59090568209, 5455.699936503491, 5461.863453413656, 5537.418571050022, 5900.675462849542, 5911.408859114097, 5958.463738263534, 5964.552658550582, 5998.310194327664, 5791.594588378815, 6021.6085954413265, 6022.5483088768515, 6023.759049638009, 6027.306859711145, 5442.156465747816, 5516.7517461714315, 5577.860553486114, 5581.74882130301, 5605.0751625982075, 6126.969365153235, 6152.938470615326, 6155.6614386209185, 6156.538259630456, 6163.3528479509005, 5745.683987380734, 5921.496672782861, 5921.73352199152, 5925.05199168131, 5925.34821169671, 5823.79616713413, 5861.648301101863, 5862.944669959448, 5880.970595147082, 5965.940340596625, 5846.503047240947, 5848.327442344185, 5906.232189815297, 5907.375471745218, 5937.910931336033, 5801.796937107265, 5849.61977471463, 5879.706014699248, 5916.23088998436, 5917.792877249276, 4472.731636101845, 4503.234450143484, 4540.500544940054, 4578.198815207392, 4597.609203217764, 4087.2029954159248, 4098.5286692030795, 4099.221147981874, 4101.282275601758, 4114.855980040744, 5647.322321321468, 5658.575606829504, 5658.943410565842, 5663.348714897839, 5666.46168613981, 5744.942550574524, 5784.50831679312, 5893.02765043763, 5931.288245410492, 5985.640861548234, 5649.067903795828, 5668.0, 5692.48767610917, 5694.032014557535, 5729.598928074995, 5191.351081114861, 5199.0, 5201.479852014844, 5203.765830537635, 5237.764300606482, 5867.354590994902, 5896.321922978912, 6104.694765261808, 6193.473554747897, 6203.906941395882, 5970.940290597038, 6021.217241758543, 6027.427394397525, 6058.606190597597, 6068.332483426908, 6193.532988916664, 6215.316315205414, 6221.3156552778255, 6225.22184726891, 6226.501879849692, 5689.715514224355, 5702.429757024264, 5899.203607512931, 5939.346671866005, 5939.851503712442, 5813.476787089013, 5871.647701137946, 5878.647281163144, 5942.762289508371, 5975.55183361241, 5791.768329266951, 5794.62334948227, 5795.768169273182, 5799.797007104731, 5802.245708057925, 5585.748641311069, 5787.102999035156, 5788.27646544182, 5791.044477661138, 5792.073268277056, 5547.140193270049, 5751.1373294006235, 5768.682722450138, 5804.6807425590305, 5889.823305300848, 5804.65172089676, 5895.852603684943, 5899.439553242435, 5906.438888305604, 5908.911366329595, 5595.832125036255, 5640.661560306395, 5745.770169193353, 5751.338596061507, 5764.337101233412], "value": 5482.15015086079, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.0919365789366, 597.259398346051, 614.8309214965884, 627.654789865574, 642.9774957876475, 34995.650043499554, 45926.31110533344, 46616.76691616541, 46701.0, 50984.0, 48878.0, 49232.261516077284, 49297.50702492974, 49396.50603493964, 49396.75301623487, 8449.704260350889, 9368.859467107999, 9505.52472376382, 9526.761830954212, 9531.428114313163, 8440.788980275482, 10981.670549883516, 11275.548978040868, 11282.435878206097, 11655.125865560118, 11333.0, 11333.093352531778, 11335.489902954387, 11345.092392608612, 11386.715332116722, 11024.118070554336, 11216.102711783078, 11217.439128043565, 11220.719482012933, 11247.606333778278, 11132.10943124548, 11198.440077996067, 11199.552017919274, 11205.66383008511, 11207.159463040223, 46370.07259854784, 46583.0, 46767.53232467666, 46767.53232467666, 46779.298310525366, 3800.3159431302356, 3811.0, 3863.497745293094, 4124.13393187431, 4437.312216606431, 34636.307273854385, 35252.47121293183, 35285.64714352849, 36676.44985325222, 36989.63010369889, 4153.439285696422, 4173.10278290166, 4349.260625693608, 4391.890202744957, 4412.602865742098, 378192.0, 378692.0, 385014.07492962637, 385127.0, 385426.0, 39380.60619393826, 64251.0, 64655.67672161609, 64680.67659661765, 64707.0, 39752.60247397547, 41675.791621042306, 41721.0, 41726.0, 41757.791211043754, 17462.738058928873, 17697.29210831578, 17701.734473982902, 17721.113944302735, 17730.113494325233, 13604.65988350299, 13950.372233249325, 13959.441622335196, 14072.2963851807, 14522.273886305642, 9368.531573421302, 9701.805963880683, 9726.659566915125, 9731.124198821999, 9799.11807937289, 3682.742208045411, 3686.889393318205, 3691.1694868654877, 3701.981490092532, 3735.9439608405896, 1064.6539874540806, 1093.136422226448, 1113.3798395190445, 1115.7935781880378, 1236.758832027764, 33984.15039624029, 33991.0, 34280.82859585736, 34551.4817277741, 34655.30689386198, 1155.6706338693432, 1221.1390969366576, 1225.7364666596725, 1309.2194615323153, 1321.4449931028992, 17996.280148794165, 18053.819461805477, 18150.81849181518, 18363.17365718546, 18458.0, 155460.0, 155911.22044389707, 157129.0, 157549.212253938, 157655.0, 63521.68239158775, 64079.679601601696, 64115.67942160353, 64122.35877641257, 64283.35716642867, 1331.3476396565807, 1362.5844117544045, 1422.9619761808613, 1444.8193975753031, 1472.7834608913731, 30430.84784576063, 34266.486002709484, 35502.64497355097, 35531.28937421289, 35854.10364740902, 61575.07637385353, 62594.374056260676, 62654.68672656608, 62923.6853815728, 62974.0, 534575.0, 536652.0, 537922.0, 539605.0, 540080.0, 46698.0, 47542.28686569774, 48264.517354826, 48559.5144048555, 48560.757196213795, 52004.739976299876, 52184.47815521796, 52630.73684631552, 52699.736501317246, 52863.207051893485, 44062.77968610136, 44070.77964610285, 44537.0, 45555.316670250635, 46313.0, 44745.31528108324, 45078.32382514199, 45927.540724593666, 46128.308075379566, 46575.53424465848, 44326.55673443224, 44873.55126448694, 45685.54314456813, 45814.541854581024, 45841.54158458373, 35887.46168807522, 38872.805635971636, 39229.41155882607, 39422.80288598539, 39776.20447590974, 29318.534073295825, 29759.40481190321, 29814.254643633216, 30228.09315720532, 30251.243718907204], "value": 20535.20327102722, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.49737579337926, 419.86774166137667, 429.6541284266166, 435.96948213625046, 441.22564898602946, 16487.917560412196, 20492.0, 21168.153273869048, 22286.77713222871, 22615.321540353776, 21147.365579032616, 21548.784512154874, 21590.89204553975, 21670.133194672235, 21717.3484795456, 5691.743871525791, 5816.970915145429, 5918.201042859224, 6040.275166979968, 6043.576949613507, 5864.472197502224, 5866.911996320037, 5887.35239123696, 5893.263342082239, 5901.114832775075, 5724.227229324029, 5870.559708021894, 5875.383084776101, 5888.5289176865745, 5924.911126333109, 5907.970460147693, 5937.52499800015, 5951.285845698522, 5951.821445356603, 5955.047192449209, 5135.0, 5281.471852814726, 5339.252504649352, 5347.572194224453, 5353.785848566053, 24754.0, 24806.25581232548, 24940.0, 25274.747252527424, 25294.114705985387, 2527.898884044636, 2727.6726792784993, 2812.943741125166, 3248.187953011747, 3329.983350083234, 14358.784618230735, 14426.350814213385, 14664.706705865823, 15342.539723808304, 15592.532224033297, 1956.4521933858543, 2011.4367976966473, 2013.4865609269543, 2047.9590408191902, 2100.579884023186, 88551.09349085277, 89761.55119224363, 90730.0, 91946.0, 92229.0, 10061.144802691706, 10662.626808061681, 10848.67453976382, 10959.726006849733, 11166.720831979266, 13953.930230348784, 14539.27303634814, 14605.269736513344, 14641.48754793577, 14659.0, 9112.225460835904, 9247.861282080774, 9249.398789078688, 9348.906510934803, 9455.007224241494, 9223.0, 9248.583813728399, 9274.026227246177, 9289.535523223813, 9489.430634161972, 6909.136357955255, 6996.19543752475, 7018.1929078155645, 7114.217436082027, 7144.607046612487, 2000.0899590686204, 2005.7994200579826, 2040.908159132813, 2047.4778931372703, 2088.4361222469847, 1087.0814162033068, 1099.9010089092021, 1140.9828852567218, 1142.3774043146504, 1154.7286387698884, 21033.263835765676, 21143.154273829183, 21542.569148617255, 21620.891895540422, 21633.242836500645, 1038.4340534408614, 1062.3466568060587, 1067.5196161727254, 1075.1237741240864, 1078.5524007536942, 11378.544858205745, 11912.40437978115, 12225.877741222652, 12281.140320177501, 12324.50701971929, 455468.0, 459825.0, 464614.0, 509447.0, 515920.0, 87649.56175219083, 88744.0, 89303.0, 89831.10168898357, 90684.0, 1021.9540120694735, 1123.7640095579857, 1150.206357613244, 1154.4054811771944, 1162.3839365136491, 18355.724664129782, 18561.16474758666, 18960.51929131342, 19068.33260835864, 19102.808971910657, 29953.85023074958, 43245.0, 44640.55359446494, 44651.77674111609, 44977.77511112423, 57624.423755761905, 59358.0, 60056.0, 66282.66858665869, 67904.3209567898, 9055.139761722627, 9105.226055785333, 9225.308101892519, 9239.353245272767, 9514.952425237829, 13353.66615834573, 13363.799543006668, 13567.118137321042, 13597.79603305971, 13705.177689338672, 12005.699857503632, 12019.939900300442, 12028.15802893824, 12286.447109879899, 12541.31022793755, 11921.940390297994, 12055.21641093326, 12129.575464858688, 12290.0, 12516.186447880858, 12193.756124877274, 12363.443645036175, 12470.563530276397, 12500.374981251083, 12911.0, 9032.36773425854, 9137.497437640994, 9294.070592940921, 9425.340226184102, 9733.805323893625, 9685.612575496902, 12288.324142171909, 12403.813942791046, 12637.684057898627, 12798.552050678181], "value": 9961.118895570824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.058399084563, 1535.1786794065174, 1669.3322670931625, 1780.928762849486, 1786.562292238401, 7599.27806858349, 7849.372050235982, 8514.616842242098, 9186.816263674722, 9199.678011269598, 8406.83186336273, 8732.781680457992, 8733.34499912506, 8987.685431009915, 8992.505412202327, 2429.149797570854, 2445.217530390276, 2449.081594402099, 2464.8028157747335, 2472.4560596668703, 2042.77529471758, 2117.4494631395796, 2279.954400911989, 2376.394019525019, 2413.613821788514, 2417.9516409671796, 2443.6456713776493, 2446.877656117196, 2463.0394146282965, 2467.938301542458, 2395.1257790906366, 2405.591049521568, 2418.8548687078655, 2418.8669623170717, 2425.9393515162087, 2374.3114496795906, 2375.7743014413604, 2382.487765130488, 2386.5107652931106, 2397.8561286322874, 8772.254358379545, 8893.377463577552, 8927.196552310259, 8928.910710892873, 9005.50469724165, 5217.5565076968505, 5342.626016178869, 5348.224507446437, 5351.545118664918, 5362.276092727471, 3278.5760156085494, 3374.105861946586, 3376.9831150844334, 3388.610309814378, 3392.745544084179, 1116.35809409589, 1156.2773266708307, 1166.8249762535602, 1168.4333098447246, 1181.102362204722, 12021.338826364547, 12038.939805300917, 12045.096617753616, 12063.577774777841, 12067.758644827141, 4652.464966528825, 4687.601553867959, 4741.1465936131135, 4800.495947925418, 4817.0606731687685, 10222.0, 10245.334053286513, 10250.897491025144, 10261.076503114755, 10264.948675256575, 5389.973050134724, 5397.217403476474, 5399.730013499309, 5401.810936617199, 5421.0, 4875.34182885313, 4958.652894297365, 4962.5533701967, 4964.404271487445, 5028.949710502921, 3782.6973842092566, 3931.8427262909736, 3946.151577410813, 3986.5614782373914, 4140.213359461693, 1363.0644484831564, 1378.0560316183446, 1378.8690074443111, 1395.6231817409446, 1405.8875289976777, 852.4373913217247, 903.0, 937.6436953957589, 991.6975322526555, 994.8209322321907, 5802.564807639444, 5889.882202355929, 5967.582269241198, 6006.429389208019, 6162.691865406712, 1005.5173516711873, 1019.2559431614815, 1020.1277907389075, 1030.7680771826278, 1048.3343077145914, 4010.63904248619, 4040.7171497995446, 4159.376093585925, 4177.791110444466, 4202.180574787887, 10685.519151638195, 11132.944335278435, 11142.164337674707, 11163.106951443864, 11167.106631469625, 10972.506237219344, 10989.725256868482, 11015.118790496901, 11019.173561982883, 11075.778484430266, 7734.071911370784, 8334.458260213067, 8391.580420978926, 8397.958010210032, 8414.36892233085, 5933.732982015733, 5941.910871336847, 6012.338642749207, 6045.879082418415, 6078.331383547895, 9845.064718851698, 9992.800143997225, 10091.394516329045, 10142.746431339276, 10145.0, 10261.692149235534, 10335.431551264752, 10346.689599312032, 10398.376097434179, 10452.268341216042, 7822.804429889298, 7834.0, 7881.487703299267, 7885.881711774213, 7931.246531579491, 7348.595827229554, 7646.65590048438, 8108.351331893552, 8153.0, 8162.061362943337, 6848.3494068063455, 7295.306945840137, 7542.509736867086, 7578.848423031398, 7586.165521792488, 7278.963605182152, 7361.742339018108, 7368.336849683555, 7418.925810741824, 7421.777346679608, 6703.262641109376, 6798.52410331272, 6808.863822723617, 6813.386795188457, 6816.7614133505085, 5125.205593133071, 5209.71346575942, 5213.0, 5257.89484210306, 5454.863628409322, 4905.288733133604, 5061.013102444987, 5070.442251352422, 5075.213341932006, 5250.737463126905], "value": 4682.427345173964, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.72725280417586, 336.9663033696629, 338.98305084745755, 340.86024729860753, 349.53162761899057, 5533.750981205845, 5618.77524899004, 5630.7184640768, 5641.915371269434, 5646.0076159635355, 5187.870303242421, 5331.813386531472, 5355.223492593572, 5457.754401051952, 5460.31746031746, 4333.198358303708, 4347.0, 4349.369341445488, 4352.608265256126, 4360.78196090195, 4233.689421189105, 4338.652907767371, 4339.544347843478, 4345.760983145926, 4362.171187474386, 4315.43899293093, 4319.784010799447, 4323.762193079379, 4324.870253892373, 4329.372241025065, 4271.743695378256, 4277.508086570053, 4290.120525292307, 4313.352997050451, 4314.697971142005, 3826.215625796705, 3839.8464061437508, 3848.9230215395814, 3863.1026729952537, 3865.61343865614, 5302.787888484456, 5395.865103372408, 5431.701256430894, 5436.891262174774, 5455.236266922634, 4964.329815474901, 4997.275395067732, 5006.798368391596, 5008.424031236382, 5013.821751888303, 5732.8853422931725, 5765.711714414305, 5772.538196944234, 5774.624649397818, 5788.0739081746715, 4026.879193624196, 4177.10192308652, 4186.853460128911, 4230.773075808012, 4232.76719780412, 5987.221661184061, 5995.1906492623375, 6000.849978750566, 6002.129691194796, 6005.909911351333, 4355.760433176142, 4358.3244597087505, 4359.215341238608, 4361.214981303332, 4368.126374725068, 4233.470816147981, 4319.611234988866, 4384.934225986613, 4386.539413361615, 4389.122175564899, 4931.827386041543, 4936.0, 4946.0, 4954.380702412199, 4982.800687972441, 5786.479216870502, 5788.842231553706, 5802.187693722883, 5814.709264536757, 5829.484334073171, 1378.9241591712553, 1411.2167746900568, 1436.8275806903239, 1441.654003039284, 1443.4009885897235, 952.7427594549572, 968.6077138758814, 989.9010098990187, 1012.4431562640518, 1018.6452018814958, 5520.006398848165, 5528.668279903219, 5540.2243685884005, 5583.720813959286, 5594.328680558359, 5773.0, 5842.009667205946, 5844.9415505845245, 5921.697226610139, 5936.643801371932, 5547.0, 5550.833474995757, 5557.194206839986, 5564.19319198722, 5567.0, 3111.0355789705263, 3124.734397576186, 3132.827694476826, 3133.7806353555034, 3140.7173354398215, 5736.6844823534275, 5878.764849406061, 5975.790847320323, 5975.83471223116, 6005.429484198994, 5936.643801371932, 5939.940600593939, 5976.671283079472, 5986.73059712314, 6001.5198784097165, 5852.824415267463, 5934.97032514852, 6021.42796434338, 6034.818955431344, 6053.909191362133, 5882.205902203148, 5888.234529511136, 5891.675957822361, 5897.7935772247765, 5912.615679980788, 5830.726016853515, 5832.883342333044, 5834.15404766315, 5837.095250236051, 5839.532837372915, 5866.2373891393845, 6169.259688837368, 6222.688865556614, 6226.533010024357, 6231.813045608639, 4298.849540266076, 4306.698531102918, 4313.619641714621, 4315.503717072451, 4326.740395576276, 5738.569607279387, 5964.194833697569, 6041.365656605993, 6063.211782468427, 6068.150458935665, 5848.239728835224, 5874.706264686834, 5879.470847623564, 5879.823605291848, 5883.852903677443, 5819.476247137778, 5827.912581311199, 5845.444682755132, 5850.6997356941765, 5851.327097383685, 5173.40505841833, 5388.838334849961, 5791.262621213703, 5816.854578635399, 5822.82531524055, 5840.2991641003355, 5849.766009359748, 5856.326522449973, 5866.911996319973, 5884.352721200579, 5521.972390138184, 5638.5489160867855, 5705.831783922083, 5713.285839270091, 5737.827865164052], "value": 4418.58232511329, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.9121196668366, 807.4025221336213, 819.5287709566996, 827.3463963468859, 947.4078700811992, 15622.375104995801, 18214.726779098306, 18320.35878744244, 18341.7248741269, 18384.632307353862, 15371.00088494247, 15430.382784688627, 15485.535433936971, 15490.61273468164, 15530.534083977498, 863.7667829685981, 895.9462432254053, 898.0794685447436, 898.2634239923266, 898.8337157625828, 891.7859713668705, 894.5840184314293, 896.278495810872, 896.560685264219, 897.2821742605889, 929.6606738540418, 932.9346945713803, 933.0995589256366, 933.2627224492643, 935.6912218967758, 929.4609126706493, 930.060638754859, 930.1070971867016, 930.2790337488467, 930.418488444722, 684.5003147702205, 689.7723751162155, 689.8482333886537, 690.689189864563, 690.9689063992132, 14957.0, 15050.548483545512, 15177.544673659808, 15217.086974781549, 15217.467388641344, 14404.92797536016, 14563.635909102251, 14679.706405871822, 14900.254987250593, 14922.0, 11918.0, 11985.58050468238, 12404.875951240463, 12456.190347627375, 12839.229646221256, 4021.77880216588, 4082.5917408259234, 4101.958980410217, 4169.957510622345, 4232.78836058199, 82103.5894820528, 83240.58379708063, 84807.0, 85448.57275713644, 86609.56695216546, 12162.270263784025, 12170.939145304217, 12182.269063856196, 12217.633470995885, 12481.875181248253, 22197.445063873532, 22308.10767569279, 22339.66490502644, 22358.552828943655, 22370.32889013332, 8815.206631403205, 8863.157999989991, 8941.46351218929, 8975.326850486239, 9242.353035287466, 4652.464966528825, 4897.578958843328, 4970.453250142481, 5018.949810501921, 5028.899422011539, 3540.716742660581, 3666.211764470652, 3670.284294562535, 3670.724695647837, 3679.9080022999638, 632.1560716443599, 632.2381530256031, 643.2731013954295, 645.0646562484417, 646.2793984707018, 661.2395744893411, 701.0640794539347, 731.7914394397571, 747.271410374891, 753.1677496366436, 10233.692989210336, 10282.691519254435, 10505.9474702626, 10979.725506862393, 10995.395253261147, 706.5195666946526, 720.9366184877368, 759.9012128423269, 775.6393277126051, 794.3724457678369, 5110.642255042186, 5125.103106956342, 5128.307678463434, 5132.332796736475, 5187.351581052369, 133108.0, 134548.32725836308, 134881.32559337336, 135129.0, 137093.3145334267, 66539.0, 78851.60574197093, 94184.0, 114965.4251728736, 120067.39966300287, 94822.0, 95525.9999999986, 97982.0, 100168.49915750374, 100387.49806250921, 9700.75748106303, 9993.200543956611, 10005.849912251177, 10036.347637403545, 10140.898591013995, 49958.25062624136, 52328.0, 53517.46482535125, 53995.46004539904, 54828.72585637046, 74950.0, 81207.0, 83022.0, 83997.580012102, 86581.56709216414, 13501.324933753469, 13756.587302380945, 13884.166949983033, 13983.510577129751, 14590.781138282722, 16352.427665032143, 16366.263518141473, 17380.91309543495, 17745.378911738026, 17769.289228431237, 13891.583252502442, 14454.927725361305, 14667.0, 14776.778348324999, 15174.468893589114, 14854.851451485347, 14900.925495372454, 15034.097954122788, 15098.773518397453, 15113.54659360221, 14804.481843135438, 14911.17988510599, 14947.85052149508, 14998.175100369584, 15082.321295541946, 11413.885861141614, 11794.941025295162, 11807.291562506278, 11859.110566707704, 12013.244507891175, 12055.15613907018, 12195.939020304842, 12275.140740148461, 12385.009199264217, 12553.0], "value": 8112.406072668247, "unit": "score"}], "name": "dromaeo_css", "value": 7570.379944170735, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 113.0, 111.0, 111.0, 111.0, 111.0, 111.0, 110.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 118.0, 149.0, 118.0, 120.0, 116.0, 118.0, 159.0, 122.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 161.0, 160.0, 159.0, 160.0, 162.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 110.0, 76.0, 75.0, 75.0, 77.0, 117.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 111.0, 82.0, 83.0, 83.0, 111.0, 83.0, 82.0, 112.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 54.0, 49.0, 49.0, 49.0, 50.0, 49.0, 48.0, 50.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 64.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 76.0, 75.0, 73.0, 72.0, 74.0, 81.0, 73.0, 73.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 127.0, 121.0, 127.0, 122.0, 131.0, 117.0, 128.0, 151.0, 135.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 153.0, 152.0, 155.0, 156.0, 156.0, 151.0, 160.0, 153.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 61.0, 62.0, 62.0, 64.0, 62.0, 66.0, 61.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1464.8000000000002, "alertThreshold": 2.0}]} 03:47:44 INFO - Return code: 0 03:47:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:47:44 INFO - # TBPL SUCCESS # 03:47:44 INFO - Running post-action listener: _resource_record_post_action 03:47:44 INFO - [mozharness: 2016-10-28 10:47:44.552856Z] Finished run-tests step (success) 03:47:44 INFO - Running post-run listener: _resource_record_post_run 03:47:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 1998848; Write bytes: 358346752; Read time: 92; Write time: 287232 03:47:44 INFO - TinderboxPrint: CPU usage
12.9% 03:47:44 INFO - TinderboxPrint: I/O read bytes / time
1,998,848 / 92 03:47:44 INFO - TinderboxPrint: I/O write bytes / time
358,346,752 / 287,232 03:47:44 INFO - TinderboxPrint: CPU idle
8,269.7 (87.1%) 03:47:44 INFO - TinderboxPrint: CPU user
1,183.4 (12.5%) 03:47:44 INFO - TinderboxPrint: Swap in / out
0 / 0 03:47:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107499520; Read time: 0; Write time: 119328 03:47:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248487936; Read time: 20; Write time: 167680 03:47:45 INFO - Running post-run listener: _upload_blobber_files 03:47:45 INFO - Blob upload gear active. 03:47:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:45 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 03:47:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:47:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:46 INFO - (blobuploader) - INFO - Done attempting. 03:47:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:47:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:47:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:47 INFO - (blobuploader) - INFO - Done attempting. 03:47:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:50 INFO - (blobuploader) - INFO - Done attempting. 03:47:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:50 INFO - Return code: 0 03:47:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26b5c40b7649b7ce562425eb2cb82d2fc80235441481d5138eeb1d04da82f6df4a6f493fdf5885296b97cd8d2d7588ac3d19454c26f7d5a9c62b35b9a8ceb8e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34040773329f82c698f6c137dc7bfef456276831db54b49ee258d0177e06afa95025eae35c641503d45a37ecfd49bd75ba94904fe8044b48469443f4e1b469b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20eaf019d2024e0556df432758cc702c776949891f6f2daac22894242954223df635ef11d188a7603cb0f96029da1bd02dc6e0009178f682d052081b6970bcef"} 03:47:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:50 INFO - Contents: 03:47:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26b5c40b7649b7ce562425eb2cb82d2fc80235441481d5138eeb1d04da82f6df4a6f493fdf5885296b97cd8d2d7588ac3d19454c26f7d5a9c62b35b9a8ceb8e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34040773329f82c698f6c137dc7bfef456276831db54b49ee258d0177e06afa95025eae35c641503d45a37ecfd49bd75ba94904fe8044b48469443f4e1b469b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20eaf019d2024e0556df432758cc702c776949891f6f2daac22894242954223df635ef11d188a7603cb0f96029da1bd02dc6e0009178f682d052081b6970bcef"} 03:47:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:50 INFO - Copying logs to upload dir... 03:47:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.522327 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-28 03:47:50.177404) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 03:47:50.180898) ========= 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=652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26b5c40b7649b7ce562425eb2cb82d2fc80235441481d5138eeb1d04da82f6df4a6f493fdf5885296b97cd8d2d7588ac3d19454c26f7d5a9c62b35b9a8ceb8e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34040773329f82c698f6c137dc7bfef456276831db54b49ee258d0177e06afa95025eae35c641503d45a37ecfd49bd75ba94904fe8044b48469443f4e1b469b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20eaf019d2024e0556df432758cc702c776949891f6f2daac22894242954223df635ef11d188a7603cb0f96029da1bd02dc6e0009178f682d052081b6970bcef"} build_url:https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/LWgcv-mXQ4qtznBJ0fLVwg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26b5c40b7649b7ce562425eb2cb82d2fc80235441481d5138eeb1d04da82f6df4a6f493fdf5885296b97cd8d2d7588ac3d19454c26f7d5a9c62b35b9a8ceb8e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34040773329f82c698f6c137dc7bfef456276831db54b49ee258d0177e06afa95025eae35c641503d45a37ecfd49bd75ba94904fe8044b48469443f4e1b469b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20eaf019d2024e0556df432758cc702c776949891f6f2daac22894242954223df635ef11d188a7603cb0f96029da1bd02dc6e0009178f682d052081b6970bcef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 03:47:50.206457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:47:50.206843) ========= 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=652eb03db935cfc1c15ebda0000001ad-1477645666.302423-1746940261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 03:47:50.289647) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 03:47:50.289999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 03:47:50.290313) ========= ========= Total master_lag: 0.18 =========